builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1461022677.13 results: success (0) buildid: 20160418151628 builduid: 8c315b4aa65a4fcdaad46c949d0ca905 revision: e8ef4670ee16f419b1037b715f0d28978825439e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.130803) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.131276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.131550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.149114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.149397) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 16:37:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-04-18 16:37:57 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.206457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.370202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.370568) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.099274 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:57.481627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 16:37:57.481995) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e8ef4670ee16f419b1037b715f0d28978825439e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e8ef4670ee16f419b1037b715f0d28978825439e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 16:37:57,534 truncating revision to first 12 chars 2016-04-18 16:37:57,534 Setting DEBUG logging. 2016-04-18 16:37:57,534 attempt 1/10 2016-04-18 16:37:57,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e8ef4670ee16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 16:37:58,633 unpacking tar archive at: fx-team-e8ef4670ee16/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 16:37:58.876999) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:58.877319) ========= script_repo_revision: e8ef4670ee16f419b1037b715f0d28978825439e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:58.877698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:58.877975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:37:58.887398) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-18 16:37:58.887664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:37:59 INFO - MultiFileLogger online at 20160418 16:37:59 in /builds/slave/test 16:37:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:37:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:37:59 INFO - {'append_to_log': False, 16:37:59 INFO - 'base_work_dir': '/builds/slave/test', 16:37:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:37:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:37:59 INFO - 'branch': 'Fx-Team-Non-PGO', 16:37:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:59 INFO - 'config_files': ('talos/linux_config.py',), 16:37:59 INFO - 'default_actions': ('clobber', 16:37:59 INFO - 'read-buildbot-config', 16:37:59 INFO - 'download-and-extract', 16:37:59 INFO - 'populate-webroot', 16:37:59 INFO - 'create-virtualenv', 16:37:59 INFO - 'install', 16:37:59 INFO - 'run-tests'), 16:37:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:59 INFO - 'download_minidump_stackwalk': True, 16:37:59 INFO - 'download_symbols': 'ondemand', 16:37:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:37:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:37:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:37:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:37:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:59 INFO - 'installer_path': 'installer.exe', 16:37:59 INFO - 'log_level': 'info', 16:37:59 INFO - 'log_name': 'talos', 16:37:59 INFO - 'log_to_console': True, 16:37:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:37:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:37:59 INFO - 'opt_config_files': (), 16:37:59 INFO - 'pip_index': False, 16:37:59 INFO - 'sps_profile': False, 16:37:59 INFO - 'sps_profile_interval': 0, 16:37:59 INFO - 'suite': 'dromaeojs-e10s', 16:37:59 INFO - 'system_bits': '32', 16:37:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:59 INFO - 'title': 'talos-linux64-ix-015', 16:37:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:59 INFO - 'use_talos_json': True, 16:37:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:37:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:59 INFO - 'work_dir': 'build'} 16:37:59 INFO - ##### 16:37:59 INFO - ##### Running clobber step. 16:37:59 INFO - ##### 16:37:59 INFO - Running pre-action listener: _resource_record_pre_action 16:37:59 INFO - Running main action method: clobber 16:37:59 INFO - rmtree: /builds/slave/test/build 16:37:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:38:00 INFO - Running post-action listener: _resource_record_post_action 16:38:00 INFO - ##### 16:38:00 INFO - ##### Running read-buildbot-config step. 16:38:00 INFO - ##### 16:38:00 INFO - Running pre-action listener: _resource_record_pre_action 16:38:00 INFO - Running main action method: read_buildbot_config 16:38:00 INFO - Using buildbot properties: 16:38:00 INFO - { 16:38:00 INFO - "project": "", 16:38:00 INFO - "product": "firefox", 16:38:00 INFO - "script_repo_revision": "production", 16:38:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:38:00 INFO - "repository": "", 16:38:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:38:00 INFO - "buildid": "20160418151628", 16:38:00 INFO - "pgo_build": "False", 16:38:00 INFO - "basedir": "/builds/slave/test", 16:38:00 INFO - "buildnumber": 1162, 16:38:00 INFO - "slavename": "talos-linux64-ix-015", 16:38:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:38:00 INFO - "platform": "ubuntu64_hw", 16:38:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:38:00 INFO - "branch": "fx-team", 16:38:00 INFO - "repo_path": "integration/fx-team", 16:38:00 INFO - "revision": "e8ef4670ee16f419b1037b715f0d28978825439e", 16:38:00 INFO - "stage_platform": "linux64", 16:38:00 INFO - "builduid": "8c315b4aa65a4fcdaad46c949d0ca905", 16:38:00 INFO - "slavebuilddir": "test" 16:38:00 INFO - } 16:38:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:38:00 INFO - Running post-action listener: _resource_record_post_action 16:38:00 INFO - ##### 16:38:00 INFO - ##### Running download-and-extract step. 16:38:00 INFO - ##### 16:38:00 INFO - Running pre-action listener: _resource_record_pre_action 16:38:00 INFO - Running main action method: download_and_extract 16:38:00 INFO - mkdir: /builds/slave/test/build/tests 16:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:00 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:38:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:38:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:38:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:38:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:38:00 INFO - Downloaded 1361 bytes. 16:38:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:38:00 INFO - Using the following test package requirements: 16:38:00 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:38:00 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:38:00 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:38:00 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'jsshell-linux-x86_64.zip'], 16:38:00 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:38:00 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:38:00 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:38:00 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:38:00 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:38:00 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:38:00 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:00 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:38:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:38:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:38:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:38:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:38:02 INFO - Downloaded 22209599 bytes. 16:38:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:38:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:38:03 INFO - Return code: 0 16:38:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:03 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:38:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:38:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:38:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:38:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:38:04 INFO - Downloaded 22209599 bytes. 16:38:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:38:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:38:05 INFO - Return code: 0 16:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:05 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:38:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:38:06 INFO - Downloaded 10845952 bytes. 16:38:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:38:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:38:06 INFO - Return code: 0 16:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:06 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:38:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:38:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:38:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:38:09 INFO - Downloaded 54453839 bytes. 16:38:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:38:09 INFO - mkdir: /builds/slave/test/properties 16:38:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:38:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:38:09 INFO - Contents: 16:38:09 INFO - build_url:https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:38:10 INFO - Running post-action listener: _resource_record_post_action 16:38:10 INFO - Running post-action listener: set_extra_try_arguments 16:38:10 INFO - ##### 16:38:10 INFO - ##### Running populate-webroot step. 16:38:10 INFO - ##### 16:38:10 INFO - Running pre-action listener: _resource_record_pre_action 16:38:10 INFO - Running main action method: populate_webroot 16:38:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:38:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:38:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:38:10 INFO - '--tppagecycles', 16:38:10 INFO - '7'], 16:38:10 INFO - 'tests': ['tsvgm']}}, 16:38:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:38:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:38:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:38:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['damp', 'tps']}, 16:38:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'tests': ['damp', 'tps']}, 16:38:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['dromaeo_dom']}, 16:38:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['tsvgx', 16:38:10 INFO - 'tsvgr_opacity', 16:38:10 INFO - 'tart', 16:38:10 INFO - 'tscrollx', 16:38:10 INFO - 'cart']}, 16:38:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:38:10 INFO - 'tsvgr_opacity', 16:38:10 INFO - 'tart', 16:38:10 INFO - 'tscrollx', 16:38:10 INFO - 'cart']}, 16:38:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'talos_options': ['--disable-e10s'], 16:38:10 INFO - 'tests': ['tp5o']}, 16:38:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'tests': ['tp5o']}, 16:38:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'talos_options': ['--disable-e10s', 16:38:10 INFO - '--xperf_path', 16:38:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:10 INFO - 'tests': ['tp5n']}, 16:38:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:10 INFO - 'talos_options': ['--xperf_path', 16:38:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:10 INFO - 'tests': ['tp5n']}}, 16:38:10 INFO - 'talos.zip': {'path': '', 16:38:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:38:10 INFO - Running post-action listener: _resource_record_post_action 16:38:10 INFO - ##### 16:38:10 INFO - ##### Running create-virtualenv step. 16:38:10 INFO - ##### 16:38:10 INFO - Running pre-action listener: _resource_record_pre_action 16:38:10 INFO - Running main action method: create_virtualenv 16:38:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:38:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:38:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:38:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:10 INFO - Using real prefix '/usr' 16:38:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:38:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:13 INFO - Installing pip.................done. 16:38:13 INFO - Return code: 0 16:38:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:38:13 INFO - Using env: {'DISPLAY': ':0', 16:38:13 INFO - 'HOME': '/home/cltbld', 16:38:13 INFO - 'LANG': 'en_US.UTF-8', 16:38:13 INFO - 'LANGUAGE': 'en_US:en', 16:38:13 INFO - 'LOGNAME': 'cltbld', 16:38:13 INFO - 'MAIL': '/var/mail/cltbld', 16:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:13 INFO - 'MOZ_NO_REMOTE': '1', 16:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:13 INFO - 'NO_EM_RESTART': '1', 16:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:13 INFO - 'PWD': '/builds/slave/test', 16:38:13 INFO - 'SHELL': '/bin/bash', 16:38:13 INFO - 'SHLVL': '1', 16:38:13 INFO - 'TERM': 'linux', 16:38:13 INFO - 'TMOUT': '86400', 16:38:13 INFO - 'USER': 'cltbld', 16:38:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:13 INFO - '_': '/tools/buildbot/bin/python'} 16:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:38:13 INFO - Cleaning up... 16:38:13 INFO - Return code: 0 16:38:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:38:13 INFO - Using env: {'DISPLAY': ':0', 16:38:13 INFO - 'HOME': '/home/cltbld', 16:38:13 INFO - 'LANG': 'en_US.UTF-8', 16:38:13 INFO - 'LANGUAGE': 'en_US:en', 16:38:13 INFO - 'LOGNAME': 'cltbld', 16:38:13 INFO - 'MAIL': '/var/mail/cltbld', 16:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:13 INFO - 'MOZ_NO_REMOTE': '1', 16:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:13 INFO - 'NO_EM_RESTART': '1', 16:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:13 INFO - 'PWD': '/builds/slave/test', 16:38:13 INFO - 'SHELL': '/bin/bash', 16:38:13 INFO - 'SHLVL': '1', 16:38:13 INFO - 'TERM': 'linux', 16:38:13 INFO - 'TMOUT': '86400', 16:38:13 INFO - 'USER': 'cltbld', 16:38:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:13 INFO - '_': '/tools/buildbot/bin/python'} 16:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:13 INFO - Downloading/unpacking psutil>=0.7.1 16:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:16 INFO - Installing collected packages: psutil 16:38:16 INFO - Running setup.py install for psutil 16:38:16 INFO - building 'psutil._psutil_linux' extension 16:38:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:38:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:38:19 INFO - building 'psutil._psutil_posix' extension 16:38:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:38:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:38:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:19 INFO - Successfully installed psutil 16:38:19 INFO - Cleaning up... 16:38:19 INFO - Return code: 0 16:38:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:38:19 INFO - Using env: {'DISPLAY': ':0', 16:38:19 INFO - 'HOME': '/home/cltbld', 16:38:19 INFO - 'LANG': 'en_US.UTF-8', 16:38:19 INFO - 'LANGUAGE': 'en_US:en', 16:38:19 INFO - 'LOGNAME': 'cltbld', 16:38:19 INFO - 'MAIL': '/var/mail/cltbld', 16:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:19 INFO - 'MOZ_NO_REMOTE': '1', 16:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:19 INFO - 'NO_EM_RESTART': '1', 16:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:19 INFO - 'PWD': '/builds/slave/test', 16:38:19 INFO - 'SHELL': '/bin/bash', 16:38:19 INFO - 'SHLVL': '1', 16:38:19 INFO - 'TERM': 'linux', 16:38:19 INFO - 'TMOUT': '86400', 16:38:19 INFO - 'USER': 'cltbld', 16:38:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:19 INFO - '_': '/tools/buildbot/bin/python'} 16:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:38:21 INFO - Installing collected packages: mozsystemmonitor 16:38:21 INFO - Running setup.py install for mozsystemmonitor 16:38:21 INFO - Successfully installed mozsystemmonitor 16:38:21 INFO - Cleaning up... 16:38:21 INFO - Return code: 0 16:38:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:38:21 INFO - Using env: {'DISPLAY': ':0', 16:38:21 INFO - 'HOME': '/home/cltbld', 16:38:21 INFO - 'LANG': 'en_US.UTF-8', 16:38:21 INFO - 'LANGUAGE': 'en_US:en', 16:38:21 INFO - 'LOGNAME': 'cltbld', 16:38:21 INFO - 'MAIL': '/var/mail/cltbld', 16:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:21 INFO - 'MOZ_NO_REMOTE': '1', 16:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:21 INFO - 'NO_EM_RESTART': '1', 16:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:21 INFO - 'PWD': '/builds/slave/test', 16:38:21 INFO - 'SHELL': '/bin/bash', 16:38:21 INFO - 'SHLVL': '1', 16:38:21 INFO - 'TERM': 'linux', 16:38:21 INFO - 'TMOUT': '86400', 16:38:21 INFO - 'USER': 'cltbld', 16:38:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:21 INFO - '_': '/tools/buildbot/bin/python'} 16:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:22 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:23 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:38:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - Downloading docopt-0.6.1.tar.gz 16:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:24 INFO - Running setup.py install for blobuploader 16:38:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:38:24 INFO - Running setup.py install for requests 16:38:25 INFO - Running setup.py install for docopt 16:38:25 INFO - Successfully installed blobuploader requests docopt 16:38:25 INFO - Cleaning up... 16:38:25 INFO - Return code: 0 16:38:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:25 INFO - Using env: {'DISPLAY': ':0', 16:38:25 INFO - 'HOME': '/home/cltbld', 16:38:25 INFO - 'LANG': 'en_US.UTF-8', 16:38:25 INFO - 'LANGUAGE': 'en_US:en', 16:38:25 INFO - 'LOGNAME': 'cltbld', 16:38:25 INFO - 'MAIL': '/var/mail/cltbld', 16:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:25 INFO - 'MOZ_NO_REMOTE': '1', 16:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:25 INFO - 'NO_EM_RESTART': '1', 16:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:25 INFO - 'PWD': '/builds/slave/test', 16:38:25 INFO - 'SHELL': '/bin/bash', 16:38:25 INFO - 'SHLVL': '1', 16:38:25 INFO - 'TERM': 'linux', 16:38:25 INFO - 'TMOUT': '86400', 16:38:25 INFO - 'USER': 'cltbld', 16:38:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:25 INFO - '_': '/tools/buildbot/bin/python'} 16:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:25 INFO - Running setup.py (path:/tmp/pip-PKTjQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:25 INFO - Running setup.py (path:/tmp/pip-N0vWk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:25 INFO - Running setup.py (path:/tmp/pip-EJ_WFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:25 INFO - Running setup.py (path:/tmp/pip-BpnP9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:25 INFO - Running setup.py (path:/tmp/pip-S9wyVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:25 INFO - Running setup.py (path:/tmp/pip-eXr_G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:26 INFO - Running setup.py (path:/tmp/pip-QUxJHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:26 INFO - Running setup.py (path:/tmp/pip-UToCyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:26 INFO - Running setup.py (path:/tmp/pip-YE6Z0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:26 INFO - Running setup.py (path:/tmp/pip-lkCsQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:26 INFO - Running setup.py (path:/tmp/pip-agB9bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:26 INFO - Running setup.py (path:/tmp/pip-HzStUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:26 INFO - Running setup.py (path:/tmp/pip-iaGWLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:26 INFO - Running setup.py (path:/tmp/pip-tbSNTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:26 INFO - Running setup.py (path:/tmp/pip-fwUgps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:26 INFO - Running setup.py (path:/tmp/pip-sBGYmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:26 INFO - Running setup.py (path:/tmp/pip-zTuRZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:26 INFO - Running setup.py install for manifestparser 16:38:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:38:26 INFO - Running setup.py install for mozcrash 16:38:26 INFO - Running setup.py install for mozdebug 16:38:27 INFO - Running setup.py install for mozdevice 16:38:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Running setup.py install for mozfile 16:38:27 INFO - Running setup.py install for mozhttpd 16:38:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Running setup.py install for mozinfo 16:38:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Running setup.py install for mozInstall 16:38:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Running setup.py install for mozleak 16:38:27 INFO - Running setup.py install for mozlog 16:38:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Running setup.py install for moznetwork 16:38:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:38:27 INFO - Running setup.py install for mozprocess 16:38:28 INFO - Running setup.py install for mozprofile 16:38:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:38:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:38:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:38:28 INFO - Running setup.py install for mozrunner 16:38:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:38:28 INFO - Running setup.py install for mozscreenshot 16:38:28 INFO - Running setup.py install for moztest 16:38:28 INFO - Running setup.py install for mozversion 16:38:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:38:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:28 INFO - Cleaning up... 16:38:28 INFO - Return code: 0 16:38:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:28 INFO - Using env: {'DISPLAY': ':0', 16:38:28 INFO - 'HOME': '/home/cltbld', 16:38:28 INFO - 'LANG': 'en_US.UTF-8', 16:38:28 INFO - 'LANGUAGE': 'en_US:en', 16:38:28 INFO - 'LOGNAME': 'cltbld', 16:38:28 INFO - 'MAIL': '/var/mail/cltbld', 16:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:28 INFO - 'MOZ_NO_REMOTE': '1', 16:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:28 INFO - 'NO_EM_RESTART': '1', 16:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:28 INFO - 'PWD': '/builds/slave/test', 16:38:28 INFO - 'SHELL': '/bin/bash', 16:38:28 INFO - 'SHLVL': '1', 16:38:28 INFO - 'TERM': 'linux', 16:38:28 INFO - 'TMOUT': '86400', 16:38:28 INFO - 'USER': 'cltbld', 16:38:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:28 INFO - '_': '/tools/buildbot/bin/python'} 16:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:28 INFO - Running setup.py (path:/tmp/pip-xlhap1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:28 INFO - Running setup.py (path:/tmp/pip-pnB5Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:28 INFO - Running setup.py (path:/tmp/pip-uzCoRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:29 INFO - Running setup.py (path:/tmp/pip-xLnIKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:29 INFO - Running setup.py (path:/tmp/pip-eOSkdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:29 INFO - Running setup.py (path:/tmp/pip-cX1jQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:29 INFO - Running setup.py (path:/tmp/pip-8lhKZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:29 INFO - Running setup.py (path:/tmp/pip-6f21J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:29 INFO - Running setup.py (path:/tmp/pip-XzQV9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:29 INFO - Running setup.py (path:/tmp/pip-rwVNPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:29 INFO - Running setup.py (path:/tmp/pip-Sjn17N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:29 INFO - Running setup.py (path:/tmp/pip-0M64fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:29 INFO - Running setup.py (path:/tmp/pip-aT2zdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:29 INFO - Running setup.py (path:/tmp/pip-ZkpCcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:29 INFO - Running setup.py (path:/tmp/pip-TizIwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:29 INFO - Running setup.py (path:/tmp/pip-7dg4w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:29 INFO - Running setup.py (path:/tmp/pip-oVi_xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:31 INFO - Downloading blessings-1.6.tar.gz 16:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:32 INFO - Installing collected packages: blessings 16:38:32 INFO - Running setup.py install for blessings 16:38:32 INFO - Successfully installed blessings 16:38:32 INFO - Cleaning up... 16:38:32 INFO - Return code: 0 16:38:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:38:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:32 INFO - Reading from file tmpfile_stdout 16:38:32 INFO - Current package versions: 16:38:32 INFO - argparse == 1.2.1 16:38:32 INFO - blessings == 1.6 16:38:32 INFO - blobuploader == 1.2.4 16:38:32 INFO - docopt == 0.6.1 16:38:32 INFO - manifestparser == 1.1 16:38:32 INFO - mozInstall == 1.12 16:38:32 INFO - mozcrash == 0.17 16:38:32 INFO - mozdebug == 0.1 16:38:32 INFO - mozdevice == 0.48 16:38:32 INFO - mozfile == 1.2 16:38:32 INFO - mozhttpd == 0.7 16:38:32 INFO - mozinfo == 0.9 16:38:32 INFO - mozleak == 0.1 16:38:32 INFO - mozlog == 3.1 16:38:32 INFO - moznetwork == 0.27 16:38:32 INFO - mozprocess == 0.22 16:38:32 INFO - mozprofile == 0.28 16:38:32 INFO - mozrunner == 6.11 16:38:32 INFO - mozscreenshot == 0.1 16:38:32 INFO - mozsystemmonitor == 0.0 16:38:32 INFO - moztest == 0.7 16:38:32 INFO - mozversion == 1.4 16:38:32 INFO - psutil == 3.1.1 16:38:32 INFO - requests == 1.2.3 16:38:32 INFO - wsgiref == 0.1.2 16:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:32 INFO - Using env: {'DISPLAY': ':0', 16:38:32 INFO - 'HOME': '/home/cltbld', 16:38:32 INFO - 'LANG': 'en_US.UTF-8', 16:38:32 INFO - 'LANGUAGE': 'en_US:en', 16:38:32 INFO - 'LOGNAME': 'cltbld', 16:38:32 INFO - 'MAIL': '/var/mail/cltbld', 16:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:32 INFO - 'MOZ_NO_REMOTE': '1', 16:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:32 INFO - 'NO_EM_RESTART': '1', 16:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:32 INFO - 'PWD': '/builds/slave/test', 16:38:32 INFO - 'SHELL': '/bin/bash', 16:38:32 INFO - 'SHLVL': '1', 16:38:32 INFO - 'TERM': 'linux', 16:38:32 INFO - 'TMOUT': '86400', 16:38:32 INFO - 'USER': 'cltbld', 16:38:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:32 INFO - '_': '/tools/buildbot/bin/python'} 16:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:38:32 INFO - Cleaning up... 16:38:32 INFO - Return code: 0 16:38:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:38:32 INFO - Using env: {'DISPLAY': ':0', 16:38:32 INFO - 'HOME': '/home/cltbld', 16:38:32 INFO - 'LANG': 'en_US.UTF-8', 16:38:32 INFO - 'LANGUAGE': 'en_US:en', 16:38:32 INFO - 'LOGNAME': 'cltbld', 16:38:32 INFO - 'MAIL': '/var/mail/cltbld', 16:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:32 INFO - 'MOZ_NO_REMOTE': '1', 16:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:32 INFO - 'NO_EM_RESTART': '1', 16:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:32 INFO - 'PWD': '/builds/slave/test', 16:38:32 INFO - 'SHELL': '/bin/bash', 16:38:32 INFO - 'SHLVL': '1', 16:38:32 INFO - 'TERM': 'linux', 16:38:32 INFO - 'TMOUT': '86400', 16:38:32 INFO - 'USER': 'cltbld', 16:38:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:32 INFO - '_': '/tools/buildbot/bin/python'} 16:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:32 INFO - Downloading/unpacking jsonschema 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:34 INFO - Downloading/unpacking functools32 (from jsonschema) 16:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:34 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:35 INFO - warning: no files found matching '*.txt' 16:38:35 INFO - no previously-included directories found matching 'build' 16:38:35 INFO - no previously-included directories found matching 'dist' 16:38:35 INFO - no previously-included directories found matching '.git*' 16:38:35 INFO - Installing collected packages: jsonschema, functools32 16:38:35 INFO - Running setup.py install for functools32 16:38:35 INFO - warning: no files found matching '*.txt' 16:38:35 INFO - no previously-included directories found matching 'build' 16:38:35 INFO - no previously-included directories found matching 'dist' 16:38:35 INFO - no previously-included directories found matching '.git*' 16:38:35 INFO - Successfully installed jsonschema functools32 16:38:35 INFO - Cleaning up... 16:38:35 INFO - Return code: 0 16:38:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab9a53cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:38:35 INFO - Using env: {'DISPLAY': ':0', 16:38:35 INFO - 'HOME': '/home/cltbld', 16:38:35 INFO - 'LANG': 'en_US.UTF-8', 16:38:35 INFO - 'LANGUAGE': 'en_US:en', 16:38:35 INFO - 'LOGNAME': 'cltbld', 16:38:35 INFO - 'MAIL': '/var/mail/cltbld', 16:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:35 INFO - 'MOZ_NO_REMOTE': '1', 16:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:35 INFO - 'NO_EM_RESTART': '1', 16:38:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:35 INFO - 'PWD': '/builds/slave/test', 16:38:35 INFO - 'SHELL': '/bin/bash', 16:38:35 INFO - 'SHLVL': '1', 16:38:35 INFO - 'TERM': 'linux', 16:38:35 INFO - 'TMOUT': '86400', 16:38:35 INFO - 'USER': 'cltbld', 16:38:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:35 INFO - '_': '/tools/buildbot/bin/python'} 16:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:35 INFO - Downloading/unpacking flake8 16:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:38:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:38:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:38:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:38 INFO - no previously-included directories found matching 'docs/_build' 16:38:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:38:38 INFO - Running setup.py install for pep8 16:38:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:38 INFO - no previously-included directories found matching 'docs/_build' 16:38:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:38:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:38:38 INFO - Cleaning up... 16:38:38 INFO - Return code: 0 16:38:38 INFO - Running post-action listener: _resource_record_post_action 16:38:38 INFO - Running post-action listener: _start_resource_monitoring 16:38:38 INFO - Starting resource monitoring. 16:38:38 INFO - ##### 16:38:38 INFO - ##### Running install step. 16:38:38 INFO - ##### 16:38:38 INFO - Running pre-action listener: _resource_record_pre_action 16:38:38 INFO - Running main action method: install 16:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:38 INFO - Reading from file tmpfile_stdout 16:38:38 INFO - Detecting whether we're running mozinstall >=1.0... 16:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:38:38 INFO - Reading from file tmpfile_stdout 16:38:38 INFO - Output received: 16:38:38 INFO - Usage: mozinstall [options] installer 16:38:38 INFO - Options: 16:38:38 INFO - -h, --help show this help message and exit 16:38:38 INFO - -d DEST, --destination=DEST 16:38:38 INFO - Directory to install application into. [default: 16:38:38 INFO - "/builds/slave/test"] 16:38:38 INFO - --app=APP Application being installed. [default: firefox] 16:38:38 INFO - mkdir: /builds/slave/test/build/application 16:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:38:54 INFO - Reading from file tmpfile_stdout 16:38:54 INFO - Output received: 16:38:54 INFO - /builds/slave/test/build/application/firefox/firefox 16:38:54 INFO - Running post-action listener: _resource_record_post_action 16:38:54 INFO - ##### 16:38:54 INFO - ##### Running run-tests step. 16:38:54 INFO - ##### 16:38:54 INFO - Running pre-action listener: _resource_record_pre_action 16:38:54 INFO - Running main action method: run_tests 16:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:54 INFO - Python 2.7.3 16:38:54 INFO - Return code: 0 16:38:54 INFO - grabbing minidump binary from tooltool 16:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:38:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:54 INFO - Return code: 0 16:38:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:38:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:38:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:55 INFO - Return code: 0 16:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:38:55 INFO - Using env: {'DISPLAY': ':0', 16:38:55 INFO - 'HOME': '/home/cltbld', 16:38:55 INFO - 'LANG': 'en_US.UTF-8', 16:38:55 INFO - 'LANGUAGE': 'en_US:en', 16:38:55 INFO - 'LOGNAME': 'cltbld', 16:38:55 INFO - 'MAIL': '/var/mail/cltbld', 16:38:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:55 INFO - 'MOZ_NO_REMOTE': '1', 16:38:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:55 INFO - 'NO_EM_RESTART': '1', 16:38:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:55 INFO - 'PWD': '/builds/slave/test', 16:38:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:55 INFO - 'SHELL': '/bin/bash', 16:38:55 INFO - 'SHLVL': '1', 16:38:55 INFO - 'TERM': 'linux', 16:38:55 INFO - 'TMOUT': '86400', 16:38:55 INFO - 'USER': 'cltbld', 16:38:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618', 16:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:55 INFO - '_': '/tools/buildbot/bin/python'} 16:38:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:38:55 INFO - mozversion application_buildid: 20160418151628 16:38:55 INFO - mozversion application_changeset: e8ef4670ee16f419b1037b715f0d28978825439e 16:38:55 INFO - mozversion application_display_name: Nightly 16:38:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:55 INFO - mozversion application_name: Firefox 16:38:55 INFO - mozversion application_remotingname: firefox 16:38:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:38:55 INFO - mozversion application_vendor: Mozilla 16:38:55 INFO - mozversion application_version: 48.0a1 16:38:55 INFO - mozversion platform_buildid: 20160418151628 16:38:55 INFO - mozversion platform_changeset: e8ef4670ee16f419b1037b715f0d28978825439e 16:38:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:38:55 INFO - mozversion platform_version: 48.0a1 16:38:55 INFO - using testdate: 1461022735 16:38:55 INFO - actual date: 1461022735 16:38:55 INFO - starting webserver on 'localhost:60518' 16:38:55 INFO - SUITE-START | Running 2 tests 16:38:55 INFO - TEST-START | dromaeo_css 16:38:55 INFO - operating with platform_type : linux_ 16:38:55 INFO - Initialising browser for dromaeo_css test... 16:38:55 INFO - TEST-INFO | started process 3310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW2w19l/profile http://localhost:60518/getInfo.html) 16:39:01 INFO - PROCESS | 3310 | 16:39:01 INFO - PROCESS | 3310 | (process:3380): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:39:02 INFO - PROCESS | 3310 | __metrics Screen width/height:1600/1200 16:39:02 INFO - PROCESS | 3310 | colorDepth:24 16:39:02 INFO - PROCESS | 3310 | Browser inner width/height: 1024/697 16:39:02 INFO - PROCESS | 3310 | __metrics 16:39:03 ERROR - PROCESS | 3310 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:39:03 INFO - TEST-INFO | 3310: exit 0 16:39:03 INFO - Browser initialized. 16:39:03 INFO - Running cycle 1/1 for dromaeo_css test... 16:39:03 INFO - TEST-INFO | started process 3431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW2w19l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:05 INFO - PROCESS | 3431 | 16:39:05 INFO - PROCESS | 3431 | (process:3490): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:39:15 INFO - PROCESS | 3431 | RSS: Main: 164646912 16:39:15 INFO - PROCESS | 3431 | 16:40:05 INFO - PROCESS | 3431 | 1461022805447 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:42:17 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:60518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60518/tests/dromaeo/cssquery-ext.html) 16:42:18 INFO - PROCESS | 3431 | RSS: Main: 169746432 16:42:18 INFO - PROCESS | 3431 | 16:45:20 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:60518/tests/dromaeo/cssquery-ext.html (next: http://localhost:60518/tests/dromaeo/cssquery-jquery.html) 16:45:21 INFO - PROCESS | 3431 | RSS: Main: 165572608 16:45:21 INFO - PROCESS | 3431 | 16:48:23 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:60518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60518/tests/dromaeo/cssquery-mootools.html) 16:48:23 INFO - PROCESS | 3431 | RSS: Main: 166170624 16:48:23 INFO - PROCESS | 3431 | 16:51:25 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:60518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60518/tests/dromaeo/cssquery-prototype.html) 16:51:26 INFO - PROCESS | 3431 | RSS: Main: 163864576 16:51:26 INFO - PROCESS | 3431 | 16:54:28 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:60518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60518/tests/dromaeo/cssquery-yui.html) 16:54:29 INFO - PROCESS | 3431 | RSS: Main: 165154816 16:54:29 INFO - PROCESS | 3431 | 16:57:31 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:60518/tests/dromaeo/cssquery-yui.html (next: http://localhost:60518/tests/dromaeo/cssquery-dojo.html) 16:57:31 INFO - PROCESS | 3431 | RSS: Main: 167342080 16:57:31 INFO - PROCESS | 3431 | 16:57:31 INFO - PROCESS | 3431 | __start_tp_report 16:57:31 INFO - PROCESS | 3431 | _x_x_mozilla_page_load 16:57:31 INFO - PROCESS | 3431 | _x_x_mozilla_page_load_details 16:57:31 INFO - PROCESS | 3431 | |i|pagename|runs| 16:57:31 INFO - PROCESS | 3431 | |0;dojo.html;2615.17621949086;2675.2910478723134;2679.933001674959;2738.972610273897;2742.478929003489;4719.292106184074;4776.044791041792;4776.498467660897;4778.187708089625;4788.52114788521;4648.070385922821;4667.76661166942;4726.338312636225;4817.494163112875;4878;4383.6493080553555;4473.329000649896;4476.731396116227;4476.865694029184;4479.238529449985;484.5918795310659;4272.401863739079;4359.062801497677;4386.649068074546;4388.319810429389;4419.226635338835;4435.246008178618;4448.799804008828;4458.242098843189;4481.305397663367;4398.494173170095;4442.378067070613;4445.444319460067;4461.04087621163;4481.529439408848;4292.720973136736;4303.677224208197;4328.199283132631;4364.781760911974;4383.780810959439;4590.74750888701;4614.330922016289;4623.653226008063;4637.86086417408;4641.76791160444;4943.1102401567705;5062.594992400599;5082.567981721558;5094.286799848024;5108.310378098946;5048.444671086178;5114.309568208281;5125.333706618116;5152.742362881841;5185.844424667266;4764.595009424203;4803.927941080887;4806.423229212482;4813.470518242991;4848.539388758062;5169.405518365361;5233.241180028875;5281;5288.550473209743;5289.867753306198;5044.571211446994;5074.2895994560795;5078.7206703631655;5081.898362032739;5126.15418455958;5120.7951681933055;5122.718250496184;5145.665531740425;5157.200633901752;5221.843344699589;4974.751262436864;5014.899702006012;5085.949140508547;5115.820946266863;5138.8972220556125;4977.925331120036;5047.899042019139;5058.924116138261;5059.544640982255;5067.41724701664;4338.284183109815;4343.457067866517;4358.3244597087505;4359.106383191438;4383.671224658164;3732.757370770891;3734.3651579231055;3790.0524868782804;3791.867284645024;3829.9042523937123;4202.201581699467;4371.584699453547;4384.758838263926;4385.51759306476;4417.712848664826;5073.3911930568565;5126.487351264918;5127.6410651254055;5131.25596788471;5147.768350424165;4294.184105020036;4390.363397307373;4403.801828917706;4424.712393694464;4452.844150454718;4535.047639995571;4549.7042692224895;4566.406367172246;4569.109023740339;4595.793189306489;4787.760611969387;4832.565069143794;4840.661153719206;4843.0313937213405;4856.368672072608;4984.775685094107;5102.107131251942;5110.795568177231;5174.14626586624;5207.453217412117;4787.808487660454;4789.688670236424;4811.542903424169;4822.348982887405;4892.584130348961;4994.825181118644;4998.825041123543;5021.472745361684;5031.270465782514;5057.418396884258;4996.500349964975;5065.569426598633;5071.923921141112;5160.974195129151;5162.225666150108;4920.72935988524;4933.161362568444;4958.45456999737;4965.255211718127;5014;4757.548032936866;4949.554540091409;4966.155753521982;4975.800967961241;5027.346444962278;4842.685225460475;4893.045856058035;4924.089043526959;4950.034743225036;4972.577330926912;4938.432080310667;4952.678075925053;4954.529319714621;4978.8257410990445;5000.974995125001;4818.542238487338;4859.659823812299;4870.269459581091;4870.829520966749;4906.239532872411 16:57:31 INFO - PROCESS | 3431 | |1;ext.html;563.7237753500783;612.816155153454;628;628.1080865171459;651.5764752910604;33481.33037339252;34223.4866477003;34269.97190084295;34288;34379.140521486974;37197.25605487889;38128.61871381285;38201.23597528048;38227.42658860119;38243.61756382435;7551.811204719898;7709.421793365492;7730.884036739453;7734.767956961272;7738.922610773877;7658.463907526475;7805.960970195141;7822.491538050037;7834.294913457816;7849.4897831640765;7785;7823;7833.334166595846;7851.960740196319;7873.133955264945;7771.22287771224;7838.882416763753;7840.294373506412;7849.136594974549;7856.096548896836;7719.112302085276;7749.108852481981;7755.340796032344;7784.143744188134;7810.101838288556;30457.086287411414;34956.12609684778;35407.29185416303;35580.46629300562;35741.28517429663;2810.662720473536;3014.4423281692957;3197.9680203197904;3211.6467188609236;3351.245969656832;27308.31729206786;27675.86162069197;27688.861555692292;27956.860215698995;28024.159275221777;3161.7628677849025;3264.934701305984;3267.428200065003;3293.818839963801;3338.565986421774;228697;233508;234319;236340;236485;57732.71133644305;58376.708116459144;58637.41362586405;58864.411355885895;58965.70517147473;52932.73533632307;54467;60175.699121504986;62403;63318.683406583594;15524.611884702746;15865.762013569805;15880.444184453489;15916.0450372978;15945.043297402193;11780.469878855472;11810.40947952599;11908.761824763456;11911.166218364804;11928.224665396721;18617.81382186188;18745.437636870916;18836.62326753457;18857.75969774828;18905.81094189068;7124.964375178091;7235.2764723527225;7404.703811847466;7435.814104647319;7486.663100160397;889.9510526921082;987.8419452887504;992.7270000749852;1000.5447521377756;1017.867677201959;28120;28134.85932570324;28561.28596785097;28600.284992874927;30010.24974375658;943.8056518594295;978.4276198424002;998.4907697074544;1023.3808545829665;1071.5338827610015;13834.169949803045;13855.584332470042;14043.08719933201;14069.788953165711;14168.85831141696;322811;325618;328815;330139;330479;47231.763841180575;47762.76118619385;47949;48002.759986199846;48083;1211.2671833540758;1211.51539384247;1277.2655722959335;1284.6595652152187;1313.5533918467577;26171.953121875675;27080.458390832468;27267.59098613562;27422.862885685445;27525.862370688017;42186.36720449257;42731.35902961396;43047;43102.78448607862;43244.56755432405;296541;304551;304717;304756;305037;25495.87252063802;25841.612375814755;25889.22332330033;25915.870420647778;25963;40257.396139058525;40600.1879962405;40925.795371022956;41415.171696566504;41926.58073419227;34636.13409664779;35049.474257886664;35056.47415288824;35193.47209791804;35265.64734352624;35207.47188792119;35360.64639353574;35416.46875296821;35525.28949421049;35587.466188006685;32799.344013119124;35593.46609800803;35714.821425892704;38101;39034;29686.851565742032;30682.693173067983;30822.69177308288;30892.38215235638;30936.53595196029;23737.287881362896;24486;24624.876875615508;24826.627600586366;24866.50266994686 16:57:31 INFO - PROCESS | 3431 | |2;jquery.html;381.8014632391158;382.426360459311;385.43533723095675;387.95538513071006;396.7559950630363;15483.767743483857;16898.88763904512;17228.913855430706;17500.64998700025;17517.124143792807;15481.922590387061;16695.248713807876;17143.742843857322;17145.142742862838;17183.484495465156;4616.884577885555;4698.224792909183;4750.786214620333;4756.643251756115;4770.97614511927;3512.086857417077;5132.794688212486;5403.648762830423;5404.189371594253;5406.648567843097;5393;5396.163594642817;5404.351477822667;5406.83779486616;5417.052015897222;5846.561507886904;5939.940600593982;5957.463828255456;5981.162637230791;6034.63792172471;5077.136886729265;5287.101192797195;5291.656042357235;5310.44240354761;5310.70791106489;12062.879371206263;12112.757744845141;12119.212251203644;12219.511219551296;12232.449539770732;1661.9335226590922;1769.354185722215;1839.6320735852748;1911.7897031326543;2053.661145910923;8582.742517724479;8866.911330886738;9004.639814407416;9100.135487128713;9122.954385228099;1684.9410270640592;1751.36075332504;1760.2870837310782;1760.5686606781292;1773.0868602669636;63134;67657;69443.99999999949;70021.29978700199;70116.6494167531;10011;10060.597576096874;10081.294309398272;10175.28772985884;10320.587176513005;14131.505397311044;14201.715965680629;14211.502597409248;14215.43138274478;14310.642233944234;7142.4286057115305;7246.130464344207;7287.890681639779;7305.086864141982;7404.2595740426605;6983.1620205575655;7061.082059332254;7077.858442831218;7105.89341159883;7179.030830837874;4277.978610106992;4326.805293761789;4339.479262488521;4359.80380882861;4491.932621010687;1776.538100093985;1818.6635472437642;1838.931202397303;1916.3484415298865;1924.8363889069585;843.7131375332293;850.7660393391743;927.7170463008847;972.6595691508057;974.3082411487782;16247.59381015484;16290.674186516204;16408.343666253215;16706.498805035626;16872.57818554546;864.5979619476973;872.3457406944791;872.6422166911536;872.9519876406858;903.2051794420868;9038.819223615623;9201.263898888074;9223.262139028995;9317.953410232905;9444.386114902509;363640;383055;383166;383843;386526;77812.61093694496;78254;78357.60821195858;79864;80134.59932700299;907.7367563406671;913.830941275866;926.3654396738256;927.4064598656865;932.2681694869631;13934.79097813554;14646.707065858836;14997.775033374726;15017.774733379227;15110;31532.527012095296;32527.837360813046;33128;36088.27823443464;37909.24181516299;43849.56150438455;44211.55788442203;44783.55216447924;44999.550004499535;45831;7552.509086909334;7574.394048476219;7627.694892204249;7640.426967977312;7655.617219139132;9951.751206219902;10964.890351096386;11043.944780276048;11224.214304998572;11459.828102578302;10016.1987041038;10073.395596264247;10114.797704046025;10161.237907156845;10239.232057595858;9246.4914429707;9310.813783724423;9879;10109.949450252701;10131.493425328852;10201.234907381828;10226.744331391776;10269;10441.68674939753;10591.5233814477;6513.934860651522;6829.658517074027;7123.109611298588;7167.569945803059;7831.2560306770765;8413.368997325348;9835.311528192959;9932.510123481536;10272;10454.215933804842 16:57:31 INFO - PROCESS | 3431 | |3;mootools.html;1466.5966859113742;1496.0649594003748;1638.3200971596789;1746.807851136374;1796.7920833520188;6944.270851560576;7465;7566.394688424926;7744.4966077204945;7777.377809775211;7706.96146519268;7707.075150981876;7757.379409647228;7774.105977812554;7787.688492460295;2201.361605134513;2232.6539386395134;2234.3632064861517;2235.910563577463;2243.7868402501817;2194.484296190394;2212.889355532225;2261.9886900565475;2271.784180502858;2275.7610450902666;2212.966805497919;2216.2243214874748;2233.419310979149;2238.6865838782583;2245;2210.027587861344;2211.0271480548586;2220.034285085993;2230.839963219125;2240.1263507232193;2205.867647941129;2217.2018073493527;2236.1390864517116;2236.731592208929;2241.2603840732518;7768.7669369918995;7857.921420785776;7869;7871.724489642835;7876.173001834783;4602.861914142581;4762.095201911626;4786.904261914777;4791.592714619262;4815.036992601494;2853.8145020573597;2970.7326340629447;2997.5953246311906;3009.4432529982023;3013.969860301391;871.3856731004627;881.3169793410094;899.8965119011332;904.0778406025817;907.8910530736288;10090.142337901287;10290.12533934609;10318.122959548447;10319.43243121628;10356.326838755533;4034.9798251008556;4056.8377264909664;4140.627343539036;4159.563245859141;4239.894002649959;8363.20549547792;8365.8326833463;8372.1627837217;8374;8374.581270936429;4644.651651126112;4664.930026049612;4687;4736.265878788793;4738.8341408050555;3755.8122093895195;4198.076423186894;4336.934945975813;4342.131573685276;4352.630026447724;3446.3107378524396;3493.458513930345;3591.838367273479;3604.85580576774;3607.404778211618;1087.8477013218155;1089.0253223365044;1092.8306112552566;1096.572336788653;1114.8795460562083;870.4994628088874;872.6378552900602;879.1999280654574;880.361737740146;884.0849720539339;5417.18742188667;5417.404085550586;5464.098423760035;5481.725913704299;5655.519280861091;421.2817146764759;425.59355815196415;435.6688916423541;436.80125542877914;438.903441242926;3728.142527218755;3748.194138260287;3779.244151169777;3812.8284227209842;3861.38217885137;9418.952905235567;9620;9807;9813.264005199639;9821.901780982242;9501.714948551555;9596.712098637052;9601.51176567633;9656.468894210886;9720.270979676552;7316.670749816271;7343.302386273295;7362.77911662651;7422.591757453392;7423.591702456309;5230.895382092413;5254.42201357858;5359;5359.892802144013;5438.83683489496;8786.428882122642;8834.160754728291;8848.159424854628;8923.73228803137;8957.059508751749;8463.32293416513;8829.690960816597;8868.423552469068;8923.821523569623;8951.73144805657;6052.485538729257;6673.165854268216;6698.56459330142;6869;6936.479764017819;7370.226126256666;7379;7409.851802963803;7419.888701669587;7436.814079648052;6722.226943901318;6965.5124141309625;6997.440204783503;7059.223485416497;7072.858542829217;6697.832554186184;6703.396694297537;6732.259451460433;6764.188297404343;6932.133483314586;6206.937930620636;6219.315875253809;6233.594816336924;6309.589876658002;6443.097966284818;4781.737004464649;4782.569568738831;4796.736179510161;4824.614030877451;4877.9024419512125;4715.81136754526;4826.831060912851;4883.951160488492;4929.507049295042;4942.3080768693135 16:57:31 INFO - PROCESS | 3431 | |4;prototype.html;305.68209062574925;313.6643791143476;315.81682624078036;316.7260319823352;319.8512691598406;5253.133233016552;5257.290265814114;5324.494173053558;5340.145576707728;5347.331583552056;5241.580673546107;5255.605829562788;5259.263703081562;5266.420693723688;5301.098813201756;3867.8646247381416;3977.2840888640035;4126.8761937141935;4128.710990230685;4134.56587058359;4082.3060079786505;4096.344584866422;4111.732737372076;4118.299889018874;4130.194612050651;4093.9590604094024;4101.589841015904;4123.443335149761;4135.545090040108;4139.4204811326435;4022.095028618581;4060.92385517838;4067.3695577185586;4126.5667104953845;4154.169166166779;3615.5842078161086;3640.4903313536124;3640.5995340512522;3642.2715456908722;3648.5621725392857;5038.596912247048;5065.670731402484;5066.797328106908;5071.847844564632;5088.465711100318;4613.838515651936;4739.4075740532435;4754.95245047552;4778.116048530998;4791.928121078186;5474.890502189974;5477.178423236506;5515.420880807497;5539.14143307788;5545.724483368807;3929.607039296076;3937.1141493164096;3937.684985201177;3962.643362097396;4006.6193711597352;5613.550915926716;5835.766569337221;5837.970810145965;5844;5846.649201047951;4065.3495440729343;4069.7558146511305;4077.2049450356894;4085.754854708727;4097.7541347519245;4100.958990410118;4105.117399759007;4134.359174327984;4159.563245859202;4179.6029377209115;4653.208954477747;4686.133065382915;4687.554682305175;4705.7176569405265;4705.7411842349;5275.841724748264;5537.809370985257;5552.4181255716285;5563.666180029211;5602.607817452821;1352.4319785690034;1369.274284629148;1375.4773186189384;1379.3585982518177;1384.8892088632886;869.2003356911656;916.9495677737789;918.4718786697675;948.805494873563;952.4190243951184;4738.147133516;4747.928781068286;4755.809767609326;4781.6891902026255;4790.712557246577;5592.580556458201;5630.802921897796;5644.520215781622;5660.603757737002;5684.175794509855;4571.177188106106;4696.929546056812;4771.498992605796;4790.616750659939;4807.206810876166;3006.9548956765666;3010.9698903011126;3041;3045.7258846703903;3053.9541906871414;5334.813281535127;5343.492368225013;5354.946450535523;5361.8123365682795;5363.892722145535;5604.184033980393;5780.653160810365;5788.305403351625;5794.681292528867;5860.912086318709;5335.119705248668;5360.812371566976;5361;5368.597355198376;5383.192521121785;5470.64440811346;5590.580706446952;5614.410486898817;5629;5638.378154158172;5515.283013208257;5547.722613869209;5555.805546806004;5559.58303127259;5567.3040869891265;5278.736063196748;5351.277577527139;5359.330083739533;5374.731263436891;5386.111291636836;3734.8506059758392;3896.2336740913133;3900.4929359183125;3916.6083391661746;3924.3132451820247;5676.460736230051;5681.630694004876;5682.119271512922;5687.516561092353;5688.232088667977;5425.294711687456;5425.918611220756;5494.478024587658;5496.983058134258;5502.367227768857;5362.51737343641;5448.645838020516;5479.369872464717;5482.013237617267;5508.697021663847;5309.973450132725;5381.869807340502;5397.190421436816;5403.81145636018;5411.918821217763;5342.225377320345;5407.486288802557;5591.077472217201;5594.16087586849;5637.43625637433;5507.5593952482905;5507.834764957058;5510.256115424367;5511.807086751945;5531.446855314436 16:57:32 INFO - PROCESS | 3431 | |5;yui.html;725.8040329111141;734.8199691075686;735.4484136897327;753.4951582439764;770.6455030685884;10508.579656813718;10595.682129536108;10667.83998240027;10721.624743133993;10774.461276936161;10859.728506787314;11258.66224013279;11269.154813388988;11273.267237629549;11294.20940534163;628.1206311164384;784.0787075186632;784.4430454377399;811.5820352518458;814.242754238558;788.2629741192004;788.7791418402857;788.9053313602376;791.5448617045193;800.5396896784343;853.8292341531687;854.747849384433;854.9316054715608;855.5038077914794;856;843.5782108945527;844.1937949258444;845.1379592815294;847.7329641163045;849.4987957105307;616.0482055224688;616.0789619518803;617.1699064757894;617.4473845907933;622.7228883147002;11884.227525210834;11956.521739130425;11959.461824217931;12022.879771202352;12023.579174728842;11976.461059252355;12217.816732749016;12227.205231659913;12257.26456412618;12427.689307767378;9732;9768.51157442125;9831.606735730562;9853.556589953398;9883.90116098837;3208.7593430492807;3209.47043737783;3224.290656055664;3249.252671885456;3277.475603903364;46113;46209.075818483776;46267.074658506644;46651;48255.517444825455;10061.54723037465;10074.798504029879;10082.546285417175;10108.292419530562;10261.281710280358;16082.919585401998;16137.660039294236;16207.189640517927;16238.918805405898;16239.51281461558;6541.640209788412;6686.331366863372;6799.218089919723;6824.317568243136;6911.949811192555;3684.742068055264;3790.1996551637753;3837.213371258885;3861.1505468796818;3889.124946886984;2707.4314393977093;2784.568391899259;3016.879324826982;3128.9843550782102;3143.1513491357205;523.7904838064804;525.90796610593;526.4051621667492;534.7967772246521;541.5369858770773;586.3257254157668;591.630231105559;603.6619493083799;605.0953824033098;618.2333905956672;7060.470464715167;7365.926340736632;7670.7698769037015;7955.562444065632;8144;476.768767147933;546.7266366816592;599.4814485470037;609.7164818359485;631.1731631562668;3588.8743893964106;3638.829358106898;3711.5175027246287;3715.9442608360896;3725.1432170600374;53114.46885531172;53402.46597534053;53592;54289.72855135699;54405.45594544083;44864.55135448604;45687.771561141984;45753.31370029452;45972.540274596824;46843;41388.1722365551;41430.37854432186;42713.1457370857;43259;43286.783566082595;7106.857862842818;7165.498415110892;7224.963875180591;7259.745908893164;7265.9273407267365;25548.48903021966;25555.616665749658;26223.475530489664;26500;26768.33079173036;34121;35688.64311356957;35849;36055.63944360523;37115.628843711216;10289.921583494659;10555.841662374916;10651.360918344924;10863.750668672888;10874.401907894826;11801.05591552691;11875.465604047666;11940.641780746591;11967.10246731516;12246.571370002008;10464;10604.098651614699;10729.409882456539;10884.510197040994;11045.834312485158;10002.149817265614;10098.798024039625;10164.84752728695;10187.84718229242;10188.020972713444;10688.600150991451;10798.784024319626;10897.182711296526;11106.50020749052;11186.776264474502;9215.86176207344;9356.567292504134;9366.250699943852;9550.522473876139;9691.951540242253;9145.496997664926;9521.381110227812;9593.258629134783;9621;9765 16:57:32 INFO - PROCESS | 3431 | __end_tp_report 16:57:32 INFO - PROCESS | 3431 | __start_cc_report 16:57:32 INFO - PROCESS | 3431 | _x_x_mozilla_cycle_collect,385 16:57:32 INFO - PROCESS | 3431 | __end_cc_report 16:57:32 INFO - PROCESS | 3431 | __startTimestamp1461023851989__endTimestamp 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - PROCESS | 3431 | ------- Summary: start ------- 16:57:32 INFO - PROCESS | 3431 | Number of tests: 6 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - PROCESS | 3431 | [#0] dojo.html Cycles:165 Average:4689.77 Median:4842.69 stddev:590.23 (12.2%) stddev-sans-first:569.17 16:57:32 INFO - PROCESS | 3431 | Values: 2615.2 2675.3 2679.9 2739.0 2742.5 4719.3 4776.0 4776.5 4778.2 4788.5 4648.1 4667.8 4726.3 4817.5 4878.0 4383.6 4473.3 4476.7 4476.9 4479.2 484.6 4272.4 4359.1 4386.6 4388.3 4419.2 4435.2 4448.8 4458.2 4481.3 4398.5 4442.4 4445.4 4461.0 4481.5 4292.7 4303.7 4328.2 4364.8 4383.8 4590.7 4614.3 4623.7 4637.9 4641.8 4943.1 5062.6 5082.6 5094.3 5108.3 5048.4 5114.3 5125.3 5152.7 5185.8 4764.6 4803.9 4806.4 4813.5 4848.5 5169.4 5233.2 5281.0 5288.6 5289.9 5044.6 5074.3 5078.7 5081.9 5126.2 5120.8 5122.7 5145.7 5157.2 5221.8 4974.8 5014.9 5085.9 5115.8 5138.9 4977.9 5047.9 5058.9 5059.5 5067.4 4338.3 4343.5 4358.3 4359.1 4383.7 3732.8 3734.4 3790.1 3791.9 3829.9 4202.2 4371.6 4384.8 4385.5 4417.7 5073.4 5126.5 5127.6 5131.3 5147.8 4294.2 4390.4 4403.8 4424.7 4452.8 4535.0 4549.7 4566.4 4569.1 4595.8 4787.8 4832.6 4840.7 4843.0 4856.4 4984.8 5102.1 5110.8 5174.1 5207.5 4787.8 4789.7 4811.5 4822.3 4892.6 4994.8 4998.8 5021.5 5031.3 5057.4 4996.5 5065.6 5071.9 5161.0 5162.2 4920.7 4933.2 4958.5 4965.3 5014.0 4757.5 4949.6 4966.2 4975.8 5027.3 4842.7 4893.0 4924.1 4950.0 4972.6 4938.4 4952.7 4954.5 4978.8 5001.0 4818.5 4859.7 4870.3 4870.8 4906.2 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - PROCESS | 3431 | [#1] ext.html Cycles:180 Average:44669.80 Median:34507.64 stddev:76263.16 (221.0%) stddev-sans-first:76405.19 16:57:32 INFO - PROCESS | 3431 | Values: 563.7 612.8 628.0 628.1 651.6 33481.3 34223.5 34270.0 34288.0 34379.1 37197.3 38128.6 38201.2 38227.4 38243.6 7551.8 7709.4 7730.9 7734.8 7738.9 7658.5 7806.0 7822.5 7834.3 7849.5 7785.0 7823.0 7833.3 7852.0 7873.1 7771.2 7838.9 7840.3 7849.1 7856.1 7719.1 7749.1 7755.3 7784.1 7810.1 30457.1 34956.1 35407.3 35580.5 35741.3 2810.7 3014.4 3198.0 3211.6 3351.2 27308.3 27675.9 27688.9 27956.9 28024.2 3161.8 3264.9 3267.4 3293.8 3338.6 228697.0 233508.0 234319.0 236340.0 236485.0 57732.7 58376.7 58637.4 58864.4 58965.7 52932.7 54467.0 60175.7 62403.0 63318.7 15524.6 15865.8 15880.4 15916.0 15945.0 11780.5 11810.4 11908.8 11911.2 11928.2 18617.8 18745.4 18836.6 18857.8 18905.8 7125.0 7235.3 7404.7 7435.8 7486.7 890.0 987.8 992.7 1000.5 1017.9 28120.0 28134.9 28561.3 28600.3 30010.2 943.8 978.4 998.5 1023.4 1071.5 13834.2 13855.6 14043.1 14069.8 14168.9 322811.0 325618.0 328815.0 330139.0 330479.0 47231.8 47762.8 47949.0 48002.8 48083.0 1211.3 1211.5 1277.3 1284.7 1313.6 26172.0 27080.5 27267.6 27422.9 27525.9 42186.4 42731.4 43047.0 43102.8 43244.6 296541.0 304551.0 304717.0 304756.0 305037.0 25495.9 25841.6 25889.2 25915.9 25963.0 40257.4 40600.2 40925.8 41415.2 41926.6 34636.1 35049.5 35056.5 35193.5 35265.6 35207.5 35360.6 35416.5 35525.3 35587.5 32799.3 35593.5 35714.8 38101.0 39034.0 29686.9 30682.7 30822.7 30892.4 30936.5 23737.3 24486.0 24624.9 24826.6 24866.5 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - PROCESS | 3431 | [#2] jquery.html Cycles:180 Average:23464.91 Median:24637.74 stddev:62825.59 (255.0%) stddev-sans-first:62977.93 16:57:32 INFO - PROCESS | 3431 | Values: 381.8 382.4 385.4 388.0 396.8 15483.8 16898.9 17228.9 17500.6 17517.1 15481.9 16695.2 17143.7 17145.1 17183.5 4616.9 4698.2 4750.8 4756.6 4771.0 3512.1 5132.8 5403.6 5404.2 5406.6 5393.0 5396.2 5404.4 5406.8 5417.1 5846.6 5939.9 5957.5 5981.2 6034.6 5077.1 5287.1 5291.7 5310.4 5310.7 12062.9 12112.8 12119.2 12219.5 12232.4 1661.9 1769.4 1839.6 1911.8 2053.7 8582.7 8866.9 9004.6 9100.1 9123.0 1684.9 1751.4 1760.3 1760.6 1773.1 63134.0 67657.0 69444.0 70021.3 70116.6 10011.0 10060.6 10081.3 10175.3 10320.6 14131.5 14201.7 14211.5 14215.4 14310.6 7142.4 7246.1 7287.9 7305.1 7404.3 6983.2 7061.1 7077.9 7105.9 7179.0 4278.0 4326.8 4339.5 4359.8 4491.9 1776.5 1818.7 1838.9 1916.3 1924.8 843.7 850.8 927.7 972.7 974.3 16247.6 16290.7 16408.3 16706.5 16872.6 864.6 872.3 872.6 873.0 903.2 9038.8 9201.3 9223.3 9318.0 9444.4 363640.0 383055.0 383166.0 383843.0 386526.0 77812.6 78254.0 78357.6 79864.0 80134.6 907.7 913.8 926.4 927.4 932.3 13934.8 14646.7 14997.8 15017.8 15110.0 31532.5 32527.8 33128.0 36088.3 37909.2 43849.6 44211.6 44783.6 44999.6 45831.0 7552.5 7574.4 7627.7 7640.4 7655.6 9951.8 10964.9 11043.9 11224.2 11459.8 10016.2 10073.4 10114.8 10161.2 10239.2 9246.5 9310.8 9879.0 10109.9 10131.5 10201.2 10226.7 10269.0 10441.7 10591.5 6513.9 6829.7 7123.1 7167.6 7831.3 8413.4 9835.3 9932.5 10272.0 10454.2 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - PROCESS | 3431 | [#3] mootools.html Cycles:180 Average:5133.45 Median:5242.66 stddev:2825.39 (53.9%) stddev-sans-first:2819.88 16:57:32 INFO - PROCESS | 3431 | Values: 1466.6 1496.1 1638.3 1746.8 1796.8 6944.3 7465.0 7566.4 7744.5 7777.4 7707.0 7707.1 7757.4 7774.1 7787.7 2201.4 2232.7 2234.4 2235.9 2243.8 2194.5 2212.9 2262.0 2271.8 2275.8 2213.0 2216.2 2233.4 2238.7 2245.0 2210.0 2211.0 2220.0 2230.8 2240.1 2205.9 2217.2 2236.1 2236.7 2241.3 7768.8 7857.9 7869.0 7871.7 7876.2 4602.9 4762.1 4786.9 4791.6 4815.0 2853.8 2970.7 2997.6 3009.4 3014.0 871.4 881.3 899.9 904.1 907.9 10090.1 10290.1 10318.1 10319.4 10356.3 4035.0 4056.8 4140.6 4159.6 4239.9 8363.2 8365.8 8372.2 8374.0 8374.6 4644.7 4664.9 4687.0 4736.3 4738.8 3755.8 4198.1 4336.9 4342.1 4352.6 3446.3 3493.5 3591.8 3604.9 3607.4 1087.8 1089.0 1092.8 1096.6 1114.9 870.5 872.6 879.2 880.4 884.1 5417.2 5417.4 5464.1 5481.7 5655.5 421.3 425.6 435.7 436.8 438.9 3728.1 3748.2 3779.2 3812.8 3861.4 9419.0 9620.0 9807.0 9813.3 9821.9 9501.7 9596.7 9601.5 9656.5 9720.3 7316.7 7343.3 7362.8 7422.6 7423.6 5230.9 5254.4 5359.0 5359.9 5438.8 8786.4 8834.2 8848.2 8923.7 8957.1 8463.3 8829.7 8868.4 8923.8 8951.7 6052.5 6673.2 6698.6 6869.0 6936.5 7370.2 7379.0 7409.9 7419.9 7436.8 6722.2 6965.5 6997.4 7059.2 7072.9 6697.8 6703.4 6732.3 6764.2 6932.1 6206.9 6219.3 6233.6 6309.6 6443.1 4781.7 4782.6 4796.7 4824.6 4877.9 4715.8 4826.8 4884.0 4929.5 4942.3 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - PROCESS | 3431 | [#4] prototype.html Cycles:180 Average:4574.17 Median:5271.13 stddev:1332.10 (25.3%) stddev-sans-first:1296.73 16:57:32 INFO - PROCESS | 3431 | Values: 305.7 313.7 315.8 316.7 319.9 5253.1 5257.3 5324.5 5340.1 5347.3 5241.6 5255.6 5259.3 5266.4 5301.1 3867.9 3977.3 4126.9 4128.7 4134.6 4082.3 4096.3 4111.7 4118.3 4130.2 4094.0 4101.6 4123.4 4135.5 4139.4 4022.1 4060.9 4067.4 4126.6 4154.2 3615.6 3640.5 3640.6 3642.3 3648.6 5038.6 5065.7 5066.8 5071.8 5088.5 4613.8 4739.4 4755.0 4778.1 4791.9 5474.9 5477.2 5515.4 5539.1 5545.7 3929.6 3937.1 3937.7 3962.6 4006.6 5613.6 5835.8 5838.0 5844.0 5846.6 4065.3 4069.8 4077.2 4085.8 4097.8 4101.0 4105.1 4134.4 4159.6 4179.6 4653.2 4686.1 4687.6 4705.7 4705.7 5275.8 5537.8 5552.4 5563.7 5602.6 1352.4 1369.3 1375.5 1379.4 1384.9 869.2 916.9 918.5 948.8 952.4 4738.1 4747.9 4755.8 4781.7 4790.7 5592.6 5630.8 5644.5 5660.6 5684.2 4571.2 4696.9 4771.5 4790.6 4807.2 3007.0 3011.0 3041.0 3045.7 3054.0 5334.8 5343.5 5354.9 5361.8 5363.9 5604.2 5780.7 5788.3 5794.7 5860.9 5335.1 5360.8 5361.0 5368.6 5383.2 5470.6 5590.6 5614.4 5629.0 5638.4 5515.3 5547.7 5555.8 5559.6 5567.3 5278.7 5351.3 5359.3 5374.7 5386.1 3734.9 3896.2 3900.5 3916.6 3924.3 5676.5 5681.6 5682.1 5687.5 5688.2 5425.3 5425.9 5494.5 5497.0 5502.4 5362.5 5448.6 5479.4 5482.0 5508.7 5310.0 5381.9 5397.2 5403.8 5411.9 5342.2 5407.5 5591.1 5594.2 5637.4 5507.6 5507.8 5510.3 5511.8 5531.4 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - PROCESS | 3431 | [#5] yui.html Cycles:180 Average:12436.66 Median:45276.16 stddev:14319.32 (31.6%) stddev-sans-first:14332.48 16:57:32 INFO - PROCESS | 3431 | Values: 725.8 734.8 735.4 753.5 770.6 10508.6 10595.7 10667.8 10721.6 10774.5 10859.7 11258.7 11269.2 11273.3 11294.2 628.1 784.1 784.4 811.6 814.2 788.3 788.8 788.9 791.5 800.5 853.8 854.7 854.9 855.5 856.0 843.6 844.2 845.1 847.7 849.5 616.0 616.1 617.2 617.4 622.7 11884.2 11956.5 11959.5 12022.9 12023.6 11976.5 12217.8 12227.2 12257.3 12427.7 9732.0 9768.5 9831.6 9853.6 9883.9 3208.8 3209.5 3224.3 3249.3 3277.5 46113.0 46209.1 46267.1 46651.0 48255.5 10061.5 10074.8 10082.5 10108.3 10261.3 16082.9 16137.7 16207.2 16238.9 16239.5 6541.6 6686.3 6799.2 6824.3 6911.9 3684.7 3790.2 3837.2 3861.2 3889.1 2707.4 2784.6 3016.9 3129.0 3143.2 523.8 525.9 526.4 534.8 541.5 586.3 591.6 603.7 605.1 618.2 7060.5 7365.9 7670.8 7955.6 8144.0 476.8 546.7 599.5 609.7 631.2 3588.9 3638.8 3711.5 3715.9 3725.1 53114.5 53402.5 53592.0 54289.7 54405.5 44864.6 45687.8 45753.3 45972.5 46843.0 41388.2 41430.4 42713.1 43259.0 43286.8 7106.9 7165.5 7225.0 7259.7 7265.9 25548.5 25555.6 26223.5 26500.0 26768.3 34121.0 35688.6 35849.0 36055.6 37115.6 10289.9 10555.8 10651.4 10863.8 10874.4 11801.1 11875.5 11940.6 11967.1 12246.6 10464.0 10604.1 10729.4 10884.5 11045.8 10002.1 10098.8 10164.8 10187.8 10188.0 10688.6 10798.8 10897.2 11106.5 11186.8 9215.9 9356.6 9366.3 9550.5 9692.0 9145.5 9521.4 9593.3 9621.0 9765.0 16:57:32 INFO - PROCESS | 3431 | -------- Summary: end -------- 16:57:32 INFO - PROCESS | 3431 | 16:57:32 INFO - TEST-INFO | 3431: exit 0 16:57:32 INFO - TEST-OK | dromaeo_css | took 1117101ms 16:57:32 INFO - TEST-START | kraken 16:57:32 INFO - operating with platform_type : linux_ 16:57:32 INFO - Initialising browser for kraken test... 16:57:32 INFO - TEST-INFO | started process 3667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYLv2CL/profile http://localhost:60518/getInfo.html) 16:57:36 INFO - PROCESS | 3667 | 16:57:36 INFO - PROCESS | 3667 | (process:3737): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:37 INFO - PROCESS | 3667 | __metrics Screen width/height:1600/1200 16:57:37 INFO - PROCESS | 3667 | colorDepth:24 16:57:37 INFO - PROCESS | 3667 | Browser inner width/height: 1024/697 16:57:37 INFO - PROCESS | 3667 | __metrics 16:57:38 ERROR - PROCESS | 3667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:57:39 INFO - TEST-INFO | 3667: exit 0 16:57:39 INFO - Browser initialized. 16:57:39 INFO - Running cycle 1/1 for kraken test... 16:57:39 INFO - TEST-INFO | started process 3788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYLv2CL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:41 INFO - PROCESS | 3788 | 16:57:41 INFO - PROCESS | 3788 | (process:3849): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:51 INFO - PROCESS | 3788 | RSS: Main: 164384768 16:57:51 INFO - PROCESS | 3788 | 16:57:53 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60518/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:54 INFO - PROCESS | 3788 | RSS: Main: 167751680 16:57:54 INFO - PROCESS | 3788 | 16:57:57 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60518/tests/kraken/driver.html?testName=audio-dft) 16:57:58 INFO - PROCESS | 3788 | RSS: Main: 171016192 16:57:58 INFO - PROCESS | 3788 | 16:58:01 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60518/tests/kraken/driver.html?testName=audio-fft) 16:58:01 INFO - PROCESS | 3788 | RSS: Main: 162611200 16:58:01 INFO - PROCESS | 3788 | 16:58:03 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60518/tests/kraken/driver.html?testName=audio-oscillator) 16:58:04 INFO - PROCESS | 3788 | RSS: Main: 162344960 16:58:04 INFO - PROCESS | 3788 | 16:58:06 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:58:07 INFO - PROCESS | 3788 | RSS: Main: 163926016 16:58:07 INFO - PROCESS | 3788 | 16:58:10 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60518/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:11 INFO - PROCESS | 3788 | RSS: Main: 164200448 16:58:11 INFO - PROCESS | 3788 | 16:58:14 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60518/tests/kraken/driver.html?testName=imaging-desaturate) 16:58:15 INFO - PROCESS | 3788 | RSS: Main: 163987456 16:58:15 INFO - PROCESS | 3788 | 16:58:18 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60518/tests/kraken/driver.html?testName=json-parse-financial) 16:58:19 INFO - PROCESS | 3788 | RSS: Main: 164904960 16:58:19 INFO - PROCESS | 3788 | 16:58:20 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:58:21 INFO - PROCESS | 3788 | RSS: Main: 165531648 16:58:21 INFO - PROCESS | 3788 | 16:58:23 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:23 INFO - PROCESS | 3788 | RSS: Main: 165408768 16:58:23 INFO - PROCESS | 3788 | 16:58:26 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:26 INFO - PROCESS | 3788 | RSS: Main: 165380096 16:58:26 INFO - PROCESS | 3788 | 16:58:29 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:30 INFO - PROCESS | 3788 | RSS: Main: 165855232 16:58:30 INFO - PROCESS | 3788 | 16:58:33 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:33 INFO - PROCESS | 3788 | RSS: Main: 165629952 16:58:33 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:60518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60518/tests/kraken/driver.html?testName=ai-astar) 16:58:35 INFO - PROCESS | 3788 | RSS: Main: 167149568 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | __start_tp_report 16:58:35 INFO - PROCESS | 3788 | _x_x_mozilla_page_load 16:58:35 INFO - PROCESS | 3788 | _x_x_mozilla_page_load_details 16:58:35 INFO - PROCESS | 3788 | |i|pagename|runs| 16:58:35 INFO - PROCESS | 3788 | |0;ai-astar;115;109;113;114;114;126;115;114;113;115 16:58:35 INFO - PROCESS | 3788 | |1;audio-beat-detection;163;132;157;191;132;170;170;139;199;137 16:58:35 INFO - PROCESS | 3788 | |2;audio-dft;163;165;163;168;168;164;163;162;165;165 16:58:35 INFO - PROCESS | 3788 | |3;audio-fft;74;74;75;147;76;75;74;78;154;76 16:58:35 INFO - PROCESS | 3788 | |4;audio-oscillator;94;93;155;94;93;94;150;97;94;135 16:58:35 INFO - PROCESS | 3788 | |5;imaging-gaussian-blur;118;117;117;118;118;117;117;119;119;118 16:58:35 INFO - PROCESS | 3788 | |6;imaging-darkroom;148;148;148;148;147;147;148;148;148;147 16:58:35 INFO - PROCESS | 3788 | |7;imaging-desaturate;95;96;95;96;96;96;96;95;96;96 16:58:35 INFO - PROCESS | 3788 | |8;json-parse-financial;64;65;64;65;66;65;64;79;62;63 16:58:35 INFO - PROCESS | 3788 | |9;json-stringify-tinderbox;65;67;64;65;65;65;65;64;65;66 16:58:35 INFO - PROCESS | 3788 | |10;stanford-crypto-aes;79;86;90;80;82;81;82;80;82;81 16:58:35 INFO - PROCESS | 3788 | |11;stanford-crypto-ccm;148;133;134;144;136;134;133;134;169;139 16:58:35 INFO - PROCESS | 3788 | |12;stanford-crypto-pbkdf2;177;180;182;175;188;178;178;179;178;171 16:58:35 INFO - PROCESS | 3788 | |13;stanford-crypto-sha256-iterative;72;73;76;73;73;74;74;79;72;72 16:58:35 INFO - PROCESS | 3788 | __end_tp_report 16:58:35 INFO - PROCESS | 3788 | __start_cc_report 16:58:35 INFO - PROCESS | 3788 | _x_x_mozilla_cycle_collect,899 16:58:35 INFO - PROCESS | 3788 | __end_cc_report 16:58:35 INFO - PROCESS | 3788 | __startTimestamp1461023915885__endTimestamp 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | ------- Summary: start ------- 16:58:35 INFO - PROCESS | 3788 | Number of tests: 14 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.32 (3.8%) stddev-sans-first:4.58 16:58:35 INFO - PROCESS | 3788 | Values: 115.0 109.0 113.0 114.0 114.0 126.0 115.0 114.0 113.0 115.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#1] audio-beat-detection Cycles:10 Average:159.00 Median:166.50 stddev:24.10 (14.5%) stddev-sans-first:25.52 16:58:35 INFO - PROCESS | 3788 | Values: 163.0 132.0 157.0 191.0 132.0 170.0 170.0 139.0 199.0 137.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.07 (1.3%) stddev-sans-first:2.11 16:58:35 INFO - PROCESS | 3788 | Values: 163.0 165.0 163.0 168.0 168.0 164.0 163.0 162.0 165.0 165.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#3] audio-fft Cycles:10 Average:90.30 Median:75.00 stddev:31.79 (42.4%) stddev-sans-first:33.17 16:58:35 INFO - PROCESS | 3788 | Values: 74.0 74.0 75.0 147.0 76.0 75.0 74.0 78.0 154.0 76.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:94.00 stddev:25.86 (27.5%) stddev-sans-first:26.79 16:58:35 INFO - PROCESS | 3788 | Values: 94.0 93.0 155.0 94.0 93.0 94.0 150.0 97.0 94.0 135.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:58:35 INFO - PROCESS | 3788 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 117.0 119.0 119.0 118.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:58:35 INFO - PROCESS | 3788 | Values: 148.0 148.0 148.0 148.0 147.0 147.0 148.0 148.0 148.0 147.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 16:58:35 INFO - PROCESS | 3788 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:4.81 (7.4%) stddev-sans-first:5.06 16:58:35 INFO - PROCESS | 3788 | Values: 64.0 65.0 64.0 65.0 66.0 65.0 64.0 79.0 62.0 63.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 16:58:35 INFO - PROCESS | 3788 | Values: 65.0 67.0 64.0 65.0 65.0 65.0 65.0 64.0 65.0 66.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:3.30 (4.0%) stddev-sans-first:3.28 16:58:35 INFO - PROCESS | 3788 | Values: 79.0 86.0 90.0 80.0 82.0 81.0 82.0 80.0 82.0 81.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:137.50 stddev:11.27 (8.2%) stddev-sans-first:11.61 16:58:35 INFO - PROCESS | 3788 | Values: 148.0 133.0 134.0 144.0 136.0 134.0 133.0 134.0 169.0 139.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:178.50 stddev:4.43 (2.5%) stddev-sans-first:4.66 16:58:35 INFO - PROCESS | 3788 | Values: 177.0 180.0 182.0 175.0 188.0 178.0 178.0 179.0 178.0 171.0 16:58:35 INFO - PROCESS | 3788 | 16:58:35 INFO - PROCESS | 3788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:73.50 stddev:2.20 (3.0%) stddev-sans-first:2.24 16:58:35 INFO - PROCESS | 3788 | Values: 72.0 73.0 76.0 73.0 73.0 74.0 74.0 79.0 72.0 72.0 16:58:35 INFO - PROCESS | 3788 | -------- Summary: end -------- 16:58:35 INFO - PROCESS | 3788 | 16:58:36 INFO - TEST-INFO | 3788: exit 0 16:58:36 INFO - TEST-OK | kraken | took 64148ms 16:58:36 INFO - SUITE-END | took 1181s 16:58:37 INFO - Completed test suite (00:19:41) 16:58:37 INFO - javascript benchmark 16:58:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.17621949086, 2675.2910478723134, 2679.933001674959, 2738.972610273897, 2742.478929003489, 4719.292106184074, 4776.044791041792, 4776.498467660897, 4778.187708089625, 4788.52114788521, 4648.070385922821, 4667.76661166942, 4726.338312636225, 4817.494163112875, 4878.0, 4383.6493080553555, 4473.329000649896, 4476.731396116227, 4476.865694029184, 4479.238529449985, 484.5918795310659, 4272.401863739079, 4359.062801497677, 4386.649068074546, 4388.319810429389, 4419.226635338835, 4435.246008178618, 4448.799804008828, 4458.242098843189, 4481.305397663367, 4398.494173170095, 4442.378067070613, 4445.444319460067, 4461.04087621163, 4481.529439408848, 4292.720973136736, 4303.677224208197, 4328.199283132631, 4364.781760911974, 4383.780810959439, 4590.74750888701, 4614.330922016289, 4623.653226008063, 4637.86086417408, 4641.76791160444, 4943.1102401567705, 5062.594992400599, 5082.567981721558, 5094.286799848024, 5108.310378098946, 5048.444671086178, 5114.309568208281, 5125.333706618116, 5152.742362881841, 5185.844424667266, 4764.595009424203, 4803.927941080887, 4806.423229212482, 4813.470518242991, 4848.539388758062, 5169.405518365361, 5233.241180028875, 5281.0, 5288.550473209743, 5289.867753306198, 5044.571211446994, 5074.2895994560795, 5078.7206703631655, 5081.898362032739, 5126.15418455958, 5120.7951681933055, 5122.718250496184, 5145.665531740425, 5157.200633901752, 5221.843344699589, 4974.751262436864, 5014.899702006012, 5085.949140508547, 5115.820946266863, 5138.8972220556125, 4977.925331120036, 5047.899042019139, 5058.924116138261, 5059.544640982255, 5067.41724701664, 4338.284183109815, 4343.457067866517, 4358.3244597087505, 4359.106383191438, 4383.671224658164, 3732.757370770891, 3734.3651579231055, 3790.0524868782804, 3791.867284645024, 3829.9042523937123, 4202.201581699467, 4371.584699453547, 4384.758838263926, 4385.51759306476, 4417.712848664826, 5073.3911930568565, 5126.487351264918, 5127.6410651254055, 5131.25596788471, 5147.768350424165, 4294.184105020036, 4390.363397307373, 4403.801828917706, 4424.712393694464, 4452.844150454718, 4535.047639995571, 4549.7042692224895, 4566.406367172246, 4569.109023740339, 4595.793189306489, 4787.760611969387, 4832.565069143794, 4840.661153719206, 4843.0313937213405, 4856.368672072608, 4984.775685094107, 5102.107131251942, 5110.795568177231, 5174.14626586624, 5207.453217412117, 4787.808487660454, 4789.688670236424, 4811.542903424169, 4822.348982887405, 4892.584130348961, 4994.825181118644, 4998.825041123543, 5021.472745361684, 5031.270465782514, 5057.418396884258, 4996.500349964975, 5065.569426598633, 5071.923921141112, 5160.974195129151, 5162.225666150108, 4920.72935988524, 4933.161362568444, 4958.45456999737, 4965.255211718127, 5014.0, 4757.548032936866, 4949.554540091409, 4966.155753521982, 4975.800967961241, 5027.346444962278, 4842.685225460475, 4893.045856058035, 4924.089043526959, 4950.034743225036, 4972.577330926912, 4938.432080310667, 4952.678075925053, 4954.529319714621, 4978.8257410990445, 5000.974995125001, 4818.542238487338, 4859.659823812299, 4870.269459581091, 4870.829520966749, 4906.239532872411], "value": 4654.5975166217895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7237753500783, 612.816155153454, 628.0, 628.1080865171459, 651.5764752910604, 33481.33037339252, 34223.4866477003, 34269.97190084295, 34288.0, 34379.140521486974, 37197.25605487889, 38128.61871381285, 38201.23597528048, 38227.42658860119, 38243.61756382435, 7551.811204719898, 7709.421793365492, 7730.884036739453, 7734.767956961272, 7738.922610773877, 7658.463907526475, 7805.960970195141, 7822.491538050037, 7834.294913457816, 7849.4897831640765, 7785.0, 7823.0, 7833.334166595846, 7851.960740196319, 7873.133955264945, 7771.22287771224, 7838.882416763753, 7840.294373506412, 7849.136594974549, 7856.096548896836, 7719.112302085276, 7749.108852481981, 7755.340796032344, 7784.143744188134, 7810.101838288556, 30457.086287411414, 34956.12609684778, 35407.29185416303, 35580.46629300562, 35741.28517429663, 2810.662720473536, 3014.4423281692957, 3197.9680203197904, 3211.6467188609236, 3351.245969656832, 27308.31729206786, 27675.86162069197, 27688.861555692292, 27956.860215698995, 28024.159275221777, 3161.7628677849025, 3264.934701305984, 3267.428200065003, 3293.818839963801, 3338.565986421774, 228697.0, 233508.0, 234319.0, 236340.0, 236485.0, 57732.71133644305, 58376.708116459144, 58637.41362586405, 58864.411355885895, 58965.70517147473, 52932.73533632307, 54467.0, 60175.699121504986, 62403.0, 63318.683406583594, 15524.611884702746, 15865.762013569805, 15880.444184453489, 15916.0450372978, 15945.043297402193, 11780.469878855472, 11810.40947952599, 11908.761824763456, 11911.166218364804, 11928.224665396721, 18617.81382186188, 18745.437636870916, 18836.62326753457, 18857.75969774828, 18905.81094189068, 7124.964375178091, 7235.2764723527225, 7404.703811847466, 7435.814104647319, 7486.663100160397, 889.9510526921082, 987.8419452887504, 992.7270000749852, 1000.5447521377756, 1017.867677201959, 28120.0, 28134.85932570324, 28561.28596785097, 28600.284992874927, 30010.24974375658, 943.8056518594295, 978.4276198424002, 998.4907697074544, 1023.3808545829665, 1071.5338827610015, 13834.169949803045, 13855.584332470042, 14043.08719933201, 14069.788953165711, 14168.85831141696, 322811.0, 325618.0, 328815.0, 330139.0, 330479.0, 47231.763841180575, 47762.76118619385, 47949.0, 48002.759986199846, 48083.0, 1211.2671833540758, 1211.51539384247, 1277.2655722959335, 1284.6595652152187, 1313.5533918467577, 26171.953121875675, 27080.458390832468, 27267.59098613562, 27422.862885685445, 27525.862370688017, 42186.36720449257, 42731.35902961396, 43047.0, 43102.78448607862, 43244.56755432405, 296541.0, 304551.0, 304717.0, 304756.0, 305037.0, 25495.87252063802, 25841.612375814755, 25889.22332330033, 25915.870420647778, 25963.0, 40257.396139058525, 40600.1879962405, 40925.795371022956, 41415.171696566504, 41926.58073419227, 34636.13409664779, 35049.474257886664, 35056.47415288824, 35193.47209791804, 35265.64734352624, 35207.47188792119, 35360.64639353574, 35416.46875296821, 35525.28949421049, 35587.466188006685, 32799.344013119124, 35593.46609800803, 35714.821425892704, 38101.0, 39034.0, 29686.851565742032, 30682.693173067983, 30822.69177308288, 30892.38215235638, 30936.53595196029, 23737.287881362896, 24486.0, 24624.876875615508, 24826.627600586366, 24866.50266994686], "value": 17396.03765774157, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.8014632391158, 382.426360459311, 385.43533723095675, 387.95538513071006, 396.7559950630363, 15483.767743483857, 16898.88763904512, 17228.913855430706, 17500.64998700025, 17517.124143792807, 15481.922590387061, 16695.248713807876, 17143.742843857322, 17145.142742862838, 17183.484495465156, 4616.884577885555, 4698.224792909183, 4750.786214620333, 4756.643251756115, 4770.97614511927, 3512.086857417077, 5132.794688212486, 5403.648762830423, 5404.189371594253, 5406.648567843097, 5393.0, 5396.163594642817, 5404.351477822667, 5406.83779486616, 5417.052015897222, 5846.561507886904, 5939.940600593982, 5957.463828255456, 5981.162637230791, 6034.63792172471, 5077.136886729265, 5287.101192797195, 5291.656042357235, 5310.44240354761, 5310.70791106489, 12062.879371206263, 12112.757744845141, 12119.212251203644, 12219.511219551296, 12232.449539770732, 1661.9335226590922, 1769.354185722215, 1839.6320735852748, 1911.7897031326543, 2053.661145910923, 8582.742517724479, 8866.911330886738, 9004.639814407416, 9100.135487128713, 9122.954385228099, 1684.9410270640592, 1751.36075332504, 1760.2870837310782, 1760.5686606781292, 1773.0868602669636, 63134.0, 67657.0, 69443.99999999949, 70021.29978700199, 70116.6494167531, 10011.0, 10060.597576096874, 10081.294309398272, 10175.28772985884, 10320.587176513005, 14131.505397311044, 14201.715965680629, 14211.502597409248, 14215.43138274478, 14310.642233944234, 7142.4286057115305, 7246.130464344207, 7287.890681639779, 7305.086864141982, 7404.2595740426605, 6983.1620205575655, 7061.082059332254, 7077.858442831218, 7105.89341159883, 7179.030830837874, 4277.978610106992, 4326.805293761789, 4339.479262488521, 4359.80380882861, 4491.932621010687, 1776.538100093985, 1818.6635472437642, 1838.931202397303, 1916.3484415298865, 1924.8363889069585, 843.7131375332293, 850.7660393391743, 927.7170463008847, 972.6595691508057, 974.3082411487782, 16247.59381015484, 16290.674186516204, 16408.343666253215, 16706.498805035626, 16872.57818554546, 864.5979619476973, 872.3457406944791, 872.6422166911536, 872.9519876406858, 903.2051794420868, 9038.819223615623, 9201.263898888074, 9223.262139028995, 9317.953410232905, 9444.386114902509, 363640.0, 383055.0, 383166.0, 383843.0, 386526.0, 77812.61093694496, 78254.0, 78357.60821195858, 79864.0, 80134.59932700299, 907.7367563406671, 913.830941275866, 926.3654396738256, 927.4064598656865, 932.2681694869631, 13934.79097813554, 14646.707065858836, 14997.775033374726, 15017.774733379227, 15110.0, 31532.527012095296, 32527.837360813046, 33128.0, 36088.27823443464, 37909.24181516299, 43849.56150438455, 44211.55788442203, 44783.55216447924, 44999.550004499535, 45831.0, 7552.509086909334, 7574.394048476219, 7627.694892204249, 7640.426967977312, 7655.617219139132, 9951.751206219902, 10964.890351096386, 11043.944780276048, 11224.214304998572, 11459.828102578302, 10016.1987041038, 10073.395596264247, 10114.797704046025, 10161.237907156845, 10239.232057595858, 9246.4914429707, 9310.813783724423, 9879.0, 10109.949450252701, 10131.493425328852, 10201.234907381828, 10226.744331391776, 10269.0, 10441.68674939753, 10591.5233814477, 6513.934860651522, 6829.658517074027, 7123.109611298588, 7167.569945803059, 7831.2560306770765, 8413.368997325348, 9835.311528192959, 9932.510123481536, 10272.0, 10454.215933804842], "value": 7967.706428793938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.5966859113742, 1496.0649594003748, 1638.3200971596789, 1746.807851136374, 1796.7920833520188, 6944.270851560576, 7465.0, 7566.394688424926, 7744.4966077204945, 7777.377809775211, 7706.96146519268, 7707.075150981876, 7757.379409647228, 7774.105977812554, 7787.688492460295, 2201.361605134513, 2232.6539386395134, 2234.3632064861517, 2235.910563577463, 2243.7868402501817, 2194.484296190394, 2212.889355532225, 2261.9886900565475, 2271.784180502858, 2275.7610450902666, 2212.966805497919, 2216.2243214874748, 2233.419310979149, 2238.6865838782583, 2245.0, 2210.027587861344, 2211.0271480548586, 2220.034285085993, 2230.839963219125, 2240.1263507232193, 2205.867647941129, 2217.2018073493527, 2236.1390864517116, 2236.731592208929, 2241.2603840732518, 7768.7669369918995, 7857.921420785776, 7869.0, 7871.724489642835, 7876.173001834783, 4602.861914142581, 4762.095201911626, 4786.904261914777, 4791.592714619262, 4815.036992601494, 2853.8145020573597, 2970.7326340629447, 2997.5953246311906, 3009.4432529982023, 3013.969860301391, 871.3856731004627, 881.3169793410094, 899.8965119011332, 904.0778406025817, 907.8910530736288, 10090.142337901287, 10290.12533934609, 10318.122959548447, 10319.43243121628, 10356.326838755533, 4034.9798251008556, 4056.8377264909664, 4140.627343539036, 4159.563245859141, 4239.894002649959, 8363.20549547792, 8365.8326833463, 8372.1627837217, 8374.0, 8374.581270936429, 4644.651651126112, 4664.930026049612, 4687.0, 4736.265878788793, 4738.8341408050555, 3755.8122093895195, 4198.076423186894, 4336.934945975813, 4342.131573685276, 4352.630026447724, 3446.3107378524396, 3493.458513930345, 3591.838367273479, 3604.85580576774, 3607.404778211618, 1087.8477013218155, 1089.0253223365044, 1092.8306112552566, 1096.572336788653, 1114.8795460562083, 870.4994628088874, 872.6378552900602, 879.1999280654574, 880.361737740146, 884.0849720539339, 5417.18742188667, 5417.404085550586, 5464.098423760035, 5481.725913704299, 5655.519280861091, 421.2817146764759, 425.59355815196415, 435.6688916423541, 436.80125542877914, 438.903441242926, 3728.142527218755, 3748.194138260287, 3779.244151169777, 3812.8284227209842, 3861.38217885137, 9418.952905235567, 9620.0, 9807.0, 9813.264005199639, 9821.901780982242, 9501.714948551555, 9596.712098637052, 9601.51176567633, 9656.468894210886, 9720.270979676552, 7316.670749816271, 7343.302386273295, 7362.77911662651, 7422.591757453392, 7423.591702456309, 5230.895382092413, 5254.42201357858, 5359.0, 5359.892802144013, 5438.83683489496, 8786.428882122642, 8834.160754728291, 8848.159424854628, 8923.73228803137, 8957.059508751749, 8463.32293416513, 8829.690960816597, 8868.423552469068, 8923.821523569623, 8951.73144805657, 6052.485538729257, 6673.165854268216, 6698.56459330142, 6869.0, 6936.479764017819, 7370.226126256666, 7379.0, 7409.851802963803, 7419.888701669587, 7436.814079648052, 6722.226943901318, 6965.5124141309625, 6997.440204783503, 7059.223485416497, 7072.858542829217, 6697.832554186184, 6703.396694297537, 6732.259451460433, 6764.188297404343, 6932.133483314586, 6206.937930620636, 6219.315875253809, 6233.594816336924, 6309.589876658002, 6443.097966284818, 4781.737004464649, 4782.569568738831, 4796.736179510161, 4824.614030877451, 4877.9024419512125, 4715.81136754526, 4826.831060912851, 4883.951160488492, 4929.507049295042, 4942.3080768693135], "value": 4093.157376863584, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.68209062574925, 313.6643791143476, 315.81682624078036, 316.7260319823352, 319.8512691598406, 5253.133233016552, 5257.290265814114, 5324.494173053558, 5340.145576707728, 5347.331583552056, 5241.580673546107, 5255.605829562788, 5259.263703081562, 5266.420693723688, 5301.098813201756, 3867.8646247381416, 3977.2840888640035, 4126.8761937141935, 4128.710990230685, 4134.56587058359, 4082.3060079786505, 4096.344584866422, 4111.732737372076, 4118.299889018874, 4130.194612050651, 4093.9590604094024, 4101.589841015904, 4123.443335149761, 4135.545090040108, 4139.4204811326435, 4022.095028618581, 4060.92385517838, 4067.3695577185586, 4126.5667104953845, 4154.169166166779, 3615.5842078161086, 3640.4903313536124, 3640.5995340512522, 3642.2715456908722, 3648.5621725392857, 5038.596912247048, 5065.670731402484, 5066.797328106908, 5071.847844564632, 5088.465711100318, 4613.838515651936, 4739.4075740532435, 4754.95245047552, 4778.116048530998, 4791.928121078186, 5474.890502189974, 5477.178423236506, 5515.420880807497, 5539.14143307788, 5545.724483368807, 3929.607039296076, 3937.1141493164096, 3937.684985201177, 3962.643362097396, 4006.6193711597352, 5613.550915926716, 5835.766569337221, 5837.970810145965, 5844.0, 5846.649201047951, 4065.3495440729343, 4069.7558146511305, 4077.2049450356894, 4085.754854708727, 4097.7541347519245, 4100.958990410118, 4105.117399759007, 4134.359174327984, 4159.563245859202, 4179.6029377209115, 4653.208954477747, 4686.133065382915, 4687.554682305175, 4705.7176569405265, 4705.7411842349, 5275.841724748264, 5537.809370985257, 5552.4181255716285, 5563.666180029211, 5602.607817452821, 1352.4319785690034, 1369.274284629148, 1375.4773186189384, 1379.3585982518177, 1384.8892088632886, 869.2003356911656, 916.9495677737789, 918.4718786697675, 948.805494873563, 952.4190243951184, 4738.147133516, 4747.928781068286, 4755.809767609326, 4781.6891902026255, 4790.712557246577, 5592.580556458201, 5630.802921897796, 5644.520215781622, 5660.603757737002, 5684.175794509855, 4571.177188106106, 4696.929546056812, 4771.498992605796, 4790.616750659939, 4807.206810876166, 3006.9548956765666, 3010.9698903011126, 3041.0, 3045.7258846703903, 3053.9541906871414, 5334.813281535127, 5343.492368225013, 5354.946450535523, 5361.8123365682795, 5363.892722145535, 5604.184033980393, 5780.653160810365, 5788.305403351625, 5794.681292528867, 5860.912086318709, 5335.119705248668, 5360.812371566976, 5361.0, 5368.597355198376, 5383.192521121785, 5470.64440811346, 5590.580706446952, 5614.410486898817, 5629.0, 5638.378154158172, 5515.283013208257, 5547.722613869209, 5555.805546806004, 5559.58303127259, 5567.3040869891265, 5278.736063196748, 5351.277577527139, 5359.330083739533, 5374.731263436891, 5386.111291636836, 3734.8506059758392, 3896.2336740913133, 3900.4929359183125, 3916.6083391661746, 3924.3132451820247, 5676.460736230051, 5681.630694004876, 5682.119271512922, 5687.516561092353, 5688.232088667977, 5425.294711687456, 5425.918611220756, 5494.478024587658, 5496.983058134258, 5502.367227768857, 5362.51737343641, 5448.645838020516, 5479.369872464717, 5482.013237617267, 5508.697021663847, 5309.973450132725, 5381.869807340502, 5397.190421436816, 5403.81145636018, 5411.918821217763, 5342.225377320345, 5407.486288802557, 5591.077472217201, 5594.16087586849, 5637.43625637433, 5507.5593952482905, 5507.834764957058, 5510.256115424367, 5511.807086751945, 5531.446855314436], "value": 4144.85307473725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.8040329111141, 734.8199691075686, 735.4484136897327, 753.4951582439764, 770.6455030685884, 10508.579656813718, 10595.682129536108, 10667.83998240027, 10721.624743133993, 10774.461276936161, 10859.728506787314, 11258.66224013279, 11269.154813388988, 11273.267237629549, 11294.20940534163, 628.1206311164384, 784.0787075186632, 784.4430454377399, 811.5820352518458, 814.242754238558, 788.2629741192004, 788.7791418402857, 788.9053313602376, 791.5448617045193, 800.5396896784343, 853.8292341531687, 854.747849384433, 854.9316054715608, 855.5038077914794, 856.0, 843.5782108945527, 844.1937949258444, 845.1379592815294, 847.7329641163045, 849.4987957105307, 616.0482055224688, 616.0789619518803, 617.1699064757894, 617.4473845907933, 622.7228883147002, 11884.227525210834, 11956.521739130425, 11959.461824217931, 12022.879771202352, 12023.579174728842, 11976.461059252355, 12217.816732749016, 12227.205231659913, 12257.26456412618, 12427.689307767378, 9732.0, 9768.51157442125, 9831.606735730562, 9853.556589953398, 9883.90116098837, 3208.7593430492807, 3209.47043737783, 3224.290656055664, 3249.252671885456, 3277.475603903364, 46113.0, 46209.075818483776, 46267.074658506644, 46651.0, 48255.517444825455, 10061.54723037465, 10074.798504029879, 10082.546285417175, 10108.292419530562, 10261.281710280358, 16082.919585401998, 16137.660039294236, 16207.189640517927, 16238.918805405898, 16239.51281461558, 6541.640209788412, 6686.331366863372, 6799.218089919723, 6824.317568243136, 6911.949811192555, 3684.742068055264, 3790.1996551637753, 3837.213371258885, 3861.1505468796818, 3889.124946886984, 2707.4314393977093, 2784.568391899259, 3016.879324826982, 3128.9843550782102, 3143.1513491357205, 523.7904838064804, 525.90796610593, 526.4051621667492, 534.7967772246521, 541.5369858770773, 586.3257254157668, 591.630231105559, 603.6619493083799, 605.0953824033098, 618.2333905956672, 7060.470464715167, 7365.926340736632, 7670.7698769037015, 7955.562444065632, 8144.0, 476.768767147933, 546.7266366816592, 599.4814485470037, 609.7164818359485, 631.1731631562668, 3588.8743893964106, 3638.829358106898, 3711.5175027246287, 3715.9442608360896, 3725.1432170600374, 53114.46885531172, 53402.46597534053, 53592.0, 54289.72855135699, 54405.45594544083, 44864.55135448604, 45687.771561141984, 45753.31370029452, 45972.540274596824, 46843.0, 41388.1722365551, 41430.37854432186, 42713.1457370857, 43259.0, 43286.783566082595, 7106.857862842818, 7165.498415110892, 7224.963875180591, 7259.745908893164, 7265.9273407267365, 25548.48903021966, 25555.616665749658, 26223.475530489664, 26500.0, 26768.33079173036, 34121.0, 35688.64311356957, 35849.0, 36055.63944360523, 37115.628843711216, 10289.921583494659, 10555.841662374916, 10651.360918344924, 10863.750668672888, 10874.401907894826, 11801.05591552691, 11875.465604047666, 11940.641780746591, 11967.10246731516, 12246.571370002008, 10464.0, 10604.098651614699, 10729.409882456539, 10884.510197040994, 11045.834312485158, 10002.149817265614, 10098.798024039625, 10164.84752728695, 10187.84718229242, 10188.020972713444, 10688.600150991451, 10798.784024319626, 10897.182711296526, 11106.50020749052, 11186.776264474502, 9215.86176207344, 9356.567292504134, 9366.250699943852, 9550.522473876139, 9691.951540242253, 9145.496997664926, 9521.381110227812, 9593.258629134783, 9621.0, 9765.0], "value": 5809.044388461968, "unit": "score"}], "name": "dromaeo_css", "value": 6317.772821740599, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 113.0, 114.0, 114.0, 126.0, 115.0, 114.0, 113.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 157.0, 191.0, 132.0, 170.0, 170.0, 139.0, 199.0, 137.0], "value": 159.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 168.0, 168.0, 164.0, 163.0, 162.0, 165.0, 165.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 147.0, 76.0, 75.0, 74.0, 78.0, 154.0, 76.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 155.0, 94.0, 93.0, 94.0, 150.0, 97.0, 94.0, 135.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 64.0, 79.0, 62.0, 63.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 90.0, 80.0, 82.0, 81.0, 82.0, 80.0, 82.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 133.0, 134.0, 144.0, 136.0, 134.0, 133.0, 134.0, 169.0, 139.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 182.0, 175.0, 188.0, 178.0, 178.0, 179.0, 178.0, 171.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 76.0, 73.0, 73.0, 74.0, 74.0, 79.0, 72.0, 72.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1605.6999999999998, "alertThreshold": 2.0}]} 16:58:37 INFO - Return code: 0 16:58:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:58:37 ERROR - # TBPL SUCCESS # 16:58:37 INFO - Running post-action listener: _resource_record_post_action 16:58:37 INFO - Running post-run listener: _resource_record_post_run 16:58:38 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 387694592; Read time: 1248; Write time: 391552 16:58:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 97587200; Read time: 28; Write time: 99380 16:58:38 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 7798784; Write bytes: 290107392; Read time: 1220; Write time: 292172 16:58:38 INFO - Running post-run listener: _upload_blobber_files 16:58:38 INFO - Blob upload gear active. 16:58:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:58:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:58:38 INFO - (blobuploader) - INFO - Open directory for files ... 16:58:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:58:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:58:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:39 INFO - (blobuploader) - INFO - Done attempting. 16:58:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:58:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:58:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:40 INFO - (blobuploader) - INFO - Done attempting. 16:58:40 INFO - (blobuploader) - INFO - Iteration through files over. 16:58:40 INFO - Return code: 0 16:58:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:58:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:58:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af158f9a4840f84b35a4161f12c3d201c0a3f15d5cbb1e5ece13720a6eaf919f0531f95356707a38bce100e63e655f1ebcdae3419a1ed9b11708cfaf70e7acf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d5f9d0310741b4dfed3c87cfe5133878aebd82c7dc2fd90fbea33b17fcc3a27cf8715e8d62ed1627bc255c72aad87f63ba67f65cfb30710939a4d3e2c256e77"} 16:58:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:58:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:58:40 INFO - Contents: 16:58:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af158f9a4840f84b35a4161f12c3d201c0a3f15d5cbb1e5ece13720a6eaf919f0531f95356707a38bce100e63e655f1ebcdae3419a1ed9b11708cfaf70e7acf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d5f9d0310741b4dfed3c87cfe5133878aebd82c7dc2fd90fbea33b17fcc3a27cf8715e8d62ed1627bc255c72aad87f63ba67f65cfb30710939a4d3e2c256e77"} 16:58:40 INFO - Running post-run listener: copy_logs_to_upload_dir 16:58:40 INFO - Copying logs to upload dir... 16:58:40 INFO - mkdir: /builds/slave/test/build/upload/logs 16:58:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.436448 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-18 16:58:40.345007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:58:40.348470) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af158f9a4840f84b35a4161f12c3d201c0a3f15d5cbb1e5ece13720a6eaf919f0531f95356707a38bce100e63e655f1ebcdae3419a1ed9b11708cfaf70e7acf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d5f9d0310741b4dfed3c87cfe5133878aebd82c7dc2fd90fbea33b17fcc3a27cf8715e8d62ed1627bc255c72aad87f63ba67f65cfb30710939a4d3e2c256e77"} build_url:https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af158f9a4840f84b35a4161f12c3d201c0a3f15d5cbb1e5ece13720a6eaf919f0531f95356707a38bce100e63e655f1ebcdae3419a1ed9b11708cfaf70e7acf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d5f9d0310741b4dfed3c87cfe5133878aebd82c7dc2fd90fbea33b17fcc3a27cf8715e8d62ed1627bc255c72aad87f63ba67f65cfb30710939a4d3e2c256e77"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:58:40.373757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:58:40.374135) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1461022676.103574-1399595618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:58:40.458188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:58:40.458514) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:58:40.458844) ========= ========= Total master_lag: 0.15 =========