builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1462933505.53 results: success (0) buildid: 20160510185609 builduid: 3125c8f9543b4e939e89f0d8575e97aa revision: 95e7b6e69427410b242d17a2642d2123114c72b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.527732) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.528139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.528442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.566183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.566459) ========= 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=0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 19:25:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 11.5M=0.001s 2016-05-10 19:25:05 (11.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.767285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.767613) ========= 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=0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019133 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.817412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:05.817767) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 95e7b6e69427410b242d17a2642d2123114c72b7 --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 95e7b6e69427410b242d17a2642d2123114c72b7 --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=0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 19:25:05,917 truncating revision to first 12 chars 2016-05-10 19:25:05,917 Setting DEBUG logging. 2016-05-10 19:25:05,917 attempt 1/10 2016-05-10 19:25:05,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/95e7b6e69427?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 19:25:06,335 unpacking tar archive at: fx-team-95e7b6e69427/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716873 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:06.551971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:06.552362) ========= script_repo_revision: 95e7b6e69427410b242d17a2642d2123114c72b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:06.552774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:06.553041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 19:25:06.563996) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-10 19:25:06.564462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:25:06 INFO - MultiFileLogger online at 20160510 19:25:06 in /builds/slave/test 19:25:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 19:25:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:25:06 INFO - {'append_to_log': False, 19:25:06 INFO - 'base_work_dir': '/builds/slave/test', 19:25:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:25:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:25:06 INFO - 'branch': 'Fx-Team-Non-PGO', 19:25:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:25:06 INFO - 'config_files': ('talos/linux_config.py',), 19:25:06 INFO - 'default_actions': ('clobber', 19:25:06 INFO - 'read-buildbot-config', 19:25:06 INFO - 'download-and-extract', 19:25:06 INFO - 'populate-webroot', 19:25:06 INFO - 'create-virtualenv', 19:25:06 INFO - 'install', 19:25:06 INFO - 'run-tests'), 19:25:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:25:06 INFO - 'download_minidump_stackwalk': True, 19:25:06 INFO - 'download_symbols': 'ondemand', 19:25:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:25:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:25:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:25:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:25:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:25:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:25:06 INFO - 'installer_path': 'installer.exe', 19:25:06 INFO - 'log_level': 'info', 19:25:06 INFO - 'log_name': 'talos', 19:25:06 INFO - 'log_to_console': True, 19:25:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:25:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:25:06 INFO - 'opt_config_files': (), 19:25:06 INFO - 'pip_index': False, 19:25:06 INFO - 'sps_profile': False, 19:25:06 INFO - 'sps_profile_interval': 0, 19:25:06 INFO - 'suite': 'dromaeojs', 19:25:06 INFO - 'system_bits': '32', 19:25:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:25:06 INFO - 'title': 'talos-linux64-ix-017', 19:25:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:25:06 INFO - 'use_talos_json': True, 19:25:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:25:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:25:06 INFO - 'work_dir': 'build'} 19:25:06 INFO - ##### 19:25:06 INFO - ##### Running clobber step. 19:25:06 INFO - ##### 19:25:06 INFO - Running pre-action listener: _resource_record_pre_action 19:25:06 INFO - Running main action method: clobber 19:25:06 INFO - rmtree: /builds/slave/test/build 19:25:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:25:07 INFO - Running post-action listener: _resource_record_post_action 19:25:07 INFO - ##### 19:25:07 INFO - ##### Finished clobber step (success) 19:25:07 INFO - ##### 19:25:07 INFO - ##### 19:25:07 INFO - ##### Running read-buildbot-config step. 19:25:07 INFO - ##### 19:25:07 INFO - Running pre-action listener: _resource_record_pre_action 19:25:07 INFO - Running main action method: read_buildbot_config 19:25:07 INFO - Using buildbot properties: 19:25:07 INFO - { 19:25:07 INFO - "project": "", 19:25:07 INFO - "product": "firefox", 19:25:07 INFO - "script_repo_revision": "production", 19:25:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:25:07 INFO - "repository": "", 19:25:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:25:07 INFO - "buildid": "20160510185609", 19:25:07 INFO - "pgo_build": "False", 19:25:07 INFO - "basedir": "/builds/slave/test", 19:25:07 INFO - "buildnumber": 1740, 19:25:07 INFO - "slavename": "talos-linux64-ix-017", 19:25:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:25:07 INFO - "platform": "ubuntu64_hw", 19:25:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:25:07 INFO - "branch": "fx-team", 19:25:07 INFO - "repo_path": "integration/fx-team", 19:25:07 INFO - "revision": "95e7b6e69427410b242d17a2642d2123114c72b7", 19:25:07 INFO - "stage_platform": "linux64", 19:25:07 INFO - "builduid": "3125c8f9543b4e939e89f0d8575e97aa", 19:25:07 INFO - "slavebuilddir": "test" 19:25:07 INFO - } 19:25:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:25:07 INFO - Running post-action listener: _resource_record_post_action 19:25:07 INFO - ##### 19:25:07 INFO - ##### Finished read-buildbot-config step (success) 19:25:07 INFO - ##### 19:25:07 INFO - ##### 19:25:07 INFO - ##### Running download-and-extract step. 19:25:07 INFO - ##### 19:25:07 INFO - Running pre-action listener: _resource_record_pre_action 19:25:07 INFO - Running main action method: download_and_extract 19:25:07 INFO - mkdir: /builds/slave/test/build/tests 19:25:07 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')]} 19:25:07 INFO - https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:25:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:25:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:25:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:25:14 INFO - Downloaded 1361 bytes. 19:25:14 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:25:14 INFO - Using the following test package requirements: 19:25:14 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:25:14 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:25:14 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:25:14 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'jsshell-linux-x86_64.zip'], 19:25:14 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:25:14 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:25:14 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:25:14 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:25:14 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:25:14 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:25:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:25:14 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')]} 19:25:14 INFO - https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:25:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:25:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:25:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:25:23 INFO - Downloaded 22329023 bytes. 19:25:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:25:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:25:24 INFO - Return code: 0 19:25:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:25:24 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')]} 19:25:24 INFO - https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:25:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:25:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:25:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:25:27 INFO - Downloaded 22329023 bytes. 19:25:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:25:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:25:28 INFO - Return code: 0 19:25: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')]} 19:25:28 INFO - https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:25:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:25:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:25:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:25:29 INFO - Downloaded 10840152 bytes. 19:25:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:25:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:25:30 INFO - Return code: 0 19:25:30 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')]} 19:25:30 INFO - https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:25:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:25:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:25:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:25:31 INFO - Downloaded 54677249 bytes. 19:25:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:25:31 INFO - mkdir: /builds/slave/test/properties 19:25:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:25:31 INFO - Writing to file /builds/slave/test/properties/build_url 19:25:31 INFO - Contents: 19:25:31 INFO - build_url:https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:25:32 INFO - Running post-action listener: _resource_record_post_action 19:25:32 INFO - Running post-action listener: set_extra_try_arguments 19:25:32 INFO - ##### 19:25:32 INFO - ##### Finished download-and-extract step (success) 19:25:32 INFO - ##### 19:25:32 INFO - ##### 19:25:32 INFO - ##### Running populate-webroot step. 19:25:32 INFO - ##### 19:25:32 INFO - Running pre-action listener: _resource_record_pre_action 19:25:32 INFO - Running main action method: populate_webroot 19:25:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:25:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:25:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:25:32 INFO - '--tppagecycles', 19:25:32 INFO - '7'], 19:25:32 INFO - 'tests': ['tsvgm']}}, 19:25:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:25:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:25:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:25:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:25:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:25:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:25:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['damp', 'tps']}, 19:25:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'tests': ['damp', 'tps']}, 19:25:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['dromaeo_dom']}, 19:25:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:25:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['a11yr', 19:25:32 INFO - 'ts_paint', 19:25:32 INFO - 'tpaint', 19:25:32 INFO - 'sessionrestore', 19:25:32 INFO - 'sessionrestore_no_auto_restore', 19:25:32 INFO - 'tabpaint']}, 19:25:32 INFO - 'other-e10s': {'tests': ['a11yr', 19:25:32 INFO - 'ts_paint', 19:25:32 INFO - 'tpaint', 19:25:32 INFO - 'sessionrestore', 19:25:32 INFO - 'sessionrestore_no_auto_restore', 19:25:32 INFO - 'tabpaint']}, 19:25:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:25:32 INFO - 'ts_paint', 19:25:32 INFO - 'tpaint', 19:25:32 INFO - 'sessionrestore', 19:25:32 INFO - 'sessionrestore_no_auto_restore', 19:25:32 INFO - 'tabpaint']}, 19:25:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:25:32 INFO - 'ts_paint', 19:25:32 INFO - 'tpaint', 19:25:32 INFO - 'sessionrestore', 19:25:32 INFO - 'sessionrestore_no_auto_restore', 19:25:32 INFO - 'tabpaint']}, 19:25:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['a11yr', 19:25:32 INFO - 'ts_paint', 19:25:32 INFO - 'tpaint', 19:25:32 INFO - 'sessionrestore', 19:25:32 INFO - 'sessionrestore_no_auto_restore', 19:25:32 INFO - 'tabpaint']}, 19:25:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['a11yr', 19:25:32 INFO - 'ts_paint', 19:25:32 INFO - 'tpaint', 19:25:32 INFO - 'sessionrestore', 19:25:32 INFO - 'sessionrestore_no_auto_restore', 19:25:32 INFO - 'tabpaint']}, 19:25:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['tsvgx', 19:25:32 INFO - 'tsvgr_opacity', 19:25:32 INFO - 'tart', 19:25:32 INFO - 'tscrollx', 19:25:32 INFO - 'cart']}, 19:25:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:25:32 INFO - 'tsvgr_opacity', 19:25:32 INFO - 'tart', 19:25:32 INFO - 'tscrollx', 19:25:32 INFO - 'cart']}, 19:25:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'talos_options': ['--disable-e10s'], 19:25:32 INFO - 'tests': ['tp5o']}, 19:25:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'tests': ['tp5o']}, 19:25:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'talos_options': ['--disable-e10s', 19:25:32 INFO - '--xperf_path', 19:25:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:25:32 INFO - 'tests': ['tp5n']}, 19:25:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:32 INFO - 'talos_options': ['--xperf_path', 19:25:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:25:32 INFO - 'tests': ['tp5n']}}, 19:25:32 INFO - 'talos.zip': {'path': '', 19:25:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:25:32 INFO - Running post-action listener: _resource_record_post_action 19:25:32 INFO - ##### 19:25:32 INFO - ##### Finished populate-webroot step (success) 19:25:32 INFO - ##### 19:25:32 INFO - ##### 19:25:32 INFO - ##### Running create-virtualenv step. 19:25:32 INFO - ##### 19:25:32 INFO - Running pre-action listener: _resource_record_pre_action 19:25:32 INFO - Running main action method: create_virtualenv 19:25:32 INFO - Creating virtualenv /builds/slave/test/build/venv 19:25:32 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 19:25:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:25:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:25:32 INFO - Using real prefix '/usr' 19:25:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:25:32 INFO - Installing distribute.............................................................................................................................................................................................done. 19:25:34 INFO - Installing pip.................done. 19:25:34 INFO - Return code: 0 19:25:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:25:34 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')]} 19:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:34 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')]} 19:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:34 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:34 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 19:25:34 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 19:25:34 INFO - Using env: {'DISPLAY': ':0', 19:25:34 INFO - 'HOME': '/home/cltbld', 19:25:34 INFO - 'LANG': 'en_US.UTF-8', 19:25:34 INFO - 'LANGUAGE': 'en_US:en', 19:25:34 INFO - 'LOGNAME': 'cltbld', 19:25:34 INFO - 'MAIL': '/var/mail/cltbld', 19:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:34 INFO - 'MOZ_NO_REMOTE': '1', 19:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:34 INFO - 'NO_EM_RESTART': '1', 19:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:34 INFO - 'PWD': '/builds/slave/test', 19:25:34 INFO - 'SHELL': '/bin/bash', 19:25:34 INFO - 'SHLVL': '1', 19:25:34 INFO - 'TERM': 'linux', 19:25:34 INFO - 'TMOUT': '86400', 19:25:34 INFO - 'USER': 'cltbld', 19:25:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:34 INFO - '_': '/tools/buildbot/bin/python'} 19:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:35 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 19:25:35 INFO - Cleaning up... 19:25:35 INFO - Return code: 0 19:25:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:25: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')]} 19:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25: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')]} 19:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25: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', '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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25: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', 'psutil>=0.7.1'] in /builds/slave/test/build 19:25: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 psutil>=0.7.1 19:25:35 INFO - Using env: {'DISPLAY': ':0', 19:25:35 INFO - 'HOME': '/home/cltbld', 19:25:35 INFO - 'LANG': 'en_US.UTF-8', 19:25:35 INFO - 'LANGUAGE': 'en_US:en', 19:25:35 INFO - 'LOGNAME': 'cltbld', 19:25:35 INFO - 'MAIL': '/var/mail/cltbld', 19:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:35 INFO - 'MOZ_NO_REMOTE': '1', 19:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:35 INFO - 'NO_EM_RESTART': '1', 19:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:35 INFO - 'PWD': '/builds/slave/test', 19:25:35 INFO - 'SHELL': '/bin/bash', 19:25:35 INFO - 'SHLVL': '1', 19:25:35 INFO - 'TERM': 'linux', 19:25:35 INFO - 'TMOUT': '86400', 19:25:35 INFO - 'USER': 'cltbld', 19:25:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:35 INFO - '_': '/tools/buildbot/bin/python'} 19:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:35 INFO - Downloading/unpacking psutil>=0.7.1 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:25:37 INFO - Installing collected packages: psutil 19:25:37 INFO - Running setup.py install for psutil 19:25:37 INFO - building 'psutil._psutil_linux' extension 19:25:37 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 19:25:37 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 19:25:37 INFO - building 'psutil._psutil_posix' extension 19:25:37 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 19:25:37 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 19:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:25:37 INFO - Successfully installed psutil 19:25:37 INFO - Cleaning up... 19:25:37 INFO - Return code: 0 19:25:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:25:37 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')]} 19:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:37 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')]} 19:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:37 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:37 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 19:25:37 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 19:25:37 INFO - Using env: {'DISPLAY': ':0', 19:25:37 INFO - 'HOME': '/home/cltbld', 19:25:37 INFO - 'LANG': 'en_US.UTF-8', 19:25:37 INFO - 'LANGUAGE': 'en_US:en', 19:25:37 INFO - 'LOGNAME': 'cltbld', 19:25:37 INFO - 'MAIL': '/var/mail/cltbld', 19:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:37 INFO - 'MOZ_NO_REMOTE': '1', 19:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:37 INFO - 'NO_EM_RESTART': '1', 19:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:37 INFO - 'PWD': '/builds/slave/test', 19:25:37 INFO - 'SHELL': '/bin/bash', 19:25:37 INFO - 'SHLVL': '1', 19:25:37 INFO - 'TERM': 'linux', 19:25:37 INFO - 'TMOUT': '86400', 19:25:37 INFO - 'USER': 'cltbld', 19:25:37 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:37 INFO - '_': '/tools/buildbot/bin/python'} 19:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:25:38 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 19:25:38 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 19:25:38 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 19:25:38 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 19:25:38 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 19:25:38 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 19:25:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:25:39 INFO - Installing collected packages: mozsystemmonitor 19:25:39 INFO - Running setup.py install for mozsystemmonitor 19:25:40 INFO - Successfully installed mozsystemmonitor 19:25:40 INFO - Cleaning up... 19:25:40 INFO - Return code: 0 19:25:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:25:40 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')]} 19:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:40 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')]} 19:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:40 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:40 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 19:25:40 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 19:25:40 INFO - Using env: {'DISPLAY': ':0', 19:25:40 INFO - 'HOME': '/home/cltbld', 19:25:40 INFO - 'LANG': 'en_US.UTF-8', 19:25:40 INFO - 'LANGUAGE': 'en_US:en', 19:25:40 INFO - 'LOGNAME': 'cltbld', 19:25:40 INFO - 'MAIL': '/var/mail/cltbld', 19:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:40 INFO - 'MOZ_NO_REMOTE': '1', 19:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:40 INFO - 'NO_EM_RESTART': '1', 19:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:40 INFO - 'PWD': '/builds/slave/test', 19:25:40 INFO - 'SHELL': '/bin/bash', 19:25:40 INFO - 'SHLVL': '1', 19:25:40 INFO - 'TERM': 'linux', 19:25:40 INFO - 'TMOUT': '86400', 19:25:40 INFO - 'USER': 'cltbld', 19:25:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:40 INFO - '_': '/tools/buildbot/bin/python'} 19:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:40 INFO - Downloading/unpacking blobuploader==1.2.4 19:25:40 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 19:25:40 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 19:25:40 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 19:25:40 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 19:25:40 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 19:25:40 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 19:25:42 INFO - Downloading blobuploader-1.2.4.tar.gz 19:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:25:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:25:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 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 19:25:42 INFO - Downloading docopt-0.6.1.tar.gz 19:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:25:43 INFO - Installing collected packages: blobuploader, requests, docopt 19:25:43 INFO - Running setup.py install for blobuploader 19:25:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:25:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:25:43 INFO - Running setup.py install for requests 19:25:43 INFO - Running setup.py install for docopt 19:25:43 INFO - Successfully installed blobuploader requests docopt 19:25:43 INFO - Cleaning up... 19:25:43 INFO - Return code: 0 19:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:43 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')]} 19:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:43 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')]} 19:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:43 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:43 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 19:25:43 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 19:25:43 INFO - Using env: {'DISPLAY': ':0', 19:25:43 INFO - 'HOME': '/home/cltbld', 19:25:43 INFO - 'LANG': 'en_US.UTF-8', 19:25:43 INFO - 'LANGUAGE': 'en_US:en', 19:25:43 INFO - 'LOGNAME': 'cltbld', 19:25:43 INFO - 'MAIL': '/var/mail/cltbld', 19:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:43 INFO - 'MOZ_NO_REMOTE': '1', 19:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:43 INFO - 'NO_EM_RESTART': '1', 19:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:43 INFO - 'PWD': '/builds/slave/test', 19:25:43 INFO - 'SHELL': '/bin/bash', 19:25:43 INFO - 'SHLVL': '1', 19:25:43 INFO - 'TERM': 'linux', 19:25:43 INFO - 'TMOUT': '86400', 19:25:43 INFO - 'USER': 'cltbld', 19:25:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:43 INFO - '_': '/tools/buildbot/bin/python'} 19:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:25:43 INFO - Running setup.py (path:/tmp/pip-zKSaAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:25:43 INFO - Running setup.py (path:/tmp/pip-OQYhIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:25:43 INFO - Running setup.py (path:/tmp/pip-3PwFhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:25:44 INFO - Running setup.py (path:/tmp/pip-e3gLHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:25:44 INFO - Running setup.py (path:/tmp/pip-MWeqAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:25:44 INFO - Running setup.py (path:/tmp/pip-n8n3MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:25:44 INFO - Running setup.py (path:/tmp/pip-PuFeyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:25:44 INFO - Running setup.py (path:/tmp/pip-ZEgRzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:25:44 INFO - Running setup.py (path:/tmp/pip-OgUDkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:25:44 INFO - Running setup.py (path:/tmp/pip-07etDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:25:44 INFO - Running setup.py (path:/tmp/pip-Lr4xbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:25:44 INFO - Running setup.py (path:/tmp/pip-xGEkZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:25:44 INFO - Running setup.py (path:/tmp/pip-mzKPiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:25:44 INFO - Running setup.py (path:/tmp/pip-Qgbv6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:44 INFO - Running setup.py (path:/tmp/pip-Bbkuc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:25:44 INFO - Running setup.py (path:/tmp/pip-DiCTbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:25:44 INFO - Running setup.py (path:/tmp/pip-AYz4QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:25:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:25:45 INFO - Running setup.py install for manifestparser 19:25:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Running setup.py install for mozcrash 19:25:45 INFO - Running setup.py install for mozdebug 19:25:45 INFO - Running setup.py install for mozdevice 19:25:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Running setup.py install for mozfile 19:25:45 INFO - Running setup.py install for mozhttpd 19:25:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Running setup.py install for mozinfo 19:25:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Running setup.py install for mozInstall 19:25:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:25:45 INFO - Running setup.py install for mozleak 19:25:45 INFO - Running setup.py install for mozlog 19:25:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:25:46 INFO - Running setup.py install for moznetwork 19:25:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:25:46 INFO - Running setup.py install for mozprocess 19:25:46 INFO - Running setup.py install for mozprofile 19:25:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:25:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:25:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:25:46 INFO - Running setup.py install for mozrunner 19:25:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:25:46 INFO - Running setup.py install for mozscreenshot 19:25:46 INFO - Running setup.py install for moztest 19:25:46 INFO - Running setup.py install for mozversion 19:25:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:25:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:25:46 INFO - Cleaning up... 19:25:46 INFO - Return code: 0 19:25:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:46 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')]} 19:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:46 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')]} 19:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:46 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:46 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 19:25:46 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 19:25:46 INFO - Using env: {'DISPLAY': ':0', 19:25:46 INFO - 'HOME': '/home/cltbld', 19:25:46 INFO - 'LANG': 'en_US.UTF-8', 19:25:46 INFO - 'LANGUAGE': 'en_US:en', 19:25:46 INFO - 'LOGNAME': 'cltbld', 19:25:46 INFO - 'MAIL': '/var/mail/cltbld', 19:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:46 INFO - 'MOZ_NO_REMOTE': '1', 19:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:46 INFO - 'NO_EM_RESTART': '1', 19:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:46 INFO - 'PWD': '/builds/slave/test', 19:25:46 INFO - 'SHELL': '/bin/bash', 19:25:46 INFO - 'SHLVL': '1', 19:25:46 INFO - 'TERM': 'linux', 19:25:46 INFO - 'TMOUT': '86400', 19:25:46 INFO - 'USER': 'cltbld', 19:25:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:46 INFO - '_': '/tools/buildbot/bin/python'} 19:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:25:47 INFO - Running setup.py (path:/tmp/pip-NSXCa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:25:47 INFO - Running setup.py (path:/tmp/pip-GDXsWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:25:47 INFO - Running setup.py (path:/tmp/pip-0lpGFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:25:47 INFO - Running setup.py (path:/tmp/pip-U2lPYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:25:47 INFO - Running setup.py (path:/tmp/pip-9S_tlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:25:47 INFO - Running setup.py (path:/tmp/pip-ielvur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:25:47 INFO - Running setup.py (path:/tmp/pip-YXGzgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:25:47 INFO - Running setup.py (path:/tmp/pip-hFnlH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:25:47 INFO - Running setup.py (path:/tmp/pip-b6zBH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:25:47 INFO - Running setup.py (path:/tmp/pip-a3oHeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:25:47 INFO - Running setup.py (path:/tmp/pip-FYc2Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:25:47 INFO - Running setup.py (path:/tmp/pip-dodez_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:25:47 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)) 19:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:25:47 INFO - Running setup.py (path:/tmp/pip-yj7epc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:25:48 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)) 19:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:25:48 INFO - Running setup.py (path:/tmp/pip-mBSn_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:25:48 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)) 19:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:48 INFO - Running setup.py (path:/tmp/pip-Ys02XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:48 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)) 19:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:25:48 INFO - Running setup.py (path:/tmp/pip-lexQb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:25:48 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)) 19:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:25:48 INFO - Running setup.py (path:/tmp/pip-K1AWp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:25:48 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)) 19:25:48 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)) 19:25:48 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)) 19:25:48 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)) 19:25:48 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)) 19:25:48 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)) 19:25:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:25:48 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 19:25:48 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 19:25:48 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 19:25:48 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 19:25:48 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 19:25:48 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 19:25:50 INFO - Downloading blessings-1.6.tar.gz 19:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:25:50 INFO - Installing collected packages: blessings 19:25:50 INFO - Running setup.py install for blessings 19:25:50 INFO - Successfully installed blessings 19:25:50 INFO - Cleaning up... 19:25:50 INFO - Return code: 0 19:25:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:50 INFO - Reading from file tmpfile_stdout 19:25:50 INFO - Current package versions: 19:25:50 INFO - argparse == 1.2.1 19:25:50 INFO - blessings == 1.6 19:25:50 INFO - blobuploader == 1.2.4 19:25:50 INFO - docopt == 0.6.1 19:25:50 INFO - manifestparser == 1.1 19:25:50 INFO - mozInstall == 1.12 19:25:50 INFO - mozcrash == 0.17 19:25:50 INFO - mozdebug == 0.1 19:25:50 INFO - mozdevice == 0.48 19:25:50 INFO - mozfile == 1.2 19:25:50 INFO - mozhttpd == 0.7 19:25:50 INFO - mozinfo == 0.9 19:25:50 INFO - mozleak == 0.1 19:25:50 INFO - mozlog == 3.1 19:25:50 INFO - moznetwork == 0.27 19:25:50 INFO - mozprocess == 0.22 19:25:50 INFO - mozprofile == 0.28 19:25:50 INFO - mozrunner == 6.11 19:25:50 INFO - mozscreenshot == 0.1 19:25:50 INFO - mozsystemmonitor == 0.0 19:25:50 INFO - moztest == 0.7 19:25:50 INFO - mozversion == 1.4 19:25:50 INFO - psutil == 3.1.1 19:25:50 INFO - requests == 1.2.3 19:25:50 INFO - wsgiref == 0.1.2 19:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:50 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')]} 19:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:50 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')]} 19:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:50 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:50 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 19:25:50 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 19:25:50 INFO - Using env: {'DISPLAY': ':0', 19:25:50 INFO - 'HOME': '/home/cltbld', 19:25:50 INFO - 'LANG': 'en_US.UTF-8', 19:25:50 INFO - 'LANGUAGE': 'en_US:en', 19:25:50 INFO - 'LOGNAME': 'cltbld', 19:25:50 INFO - 'MAIL': '/var/mail/cltbld', 19:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:50 INFO - 'MOZ_NO_REMOTE': '1', 19:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:50 INFO - 'NO_EM_RESTART': '1', 19:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:50 INFO - 'PWD': '/builds/slave/test', 19:25:50 INFO - 'SHELL': '/bin/bash', 19:25:50 INFO - 'SHLVL': '1', 19:25:50 INFO - 'TERM': 'linux', 19:25:50 INFO - 'TMOUT': '86400', 19:25:50 INFO - 'USER': 'cltbld', 19:25:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:50 INFO - '_': '/tools/buildbot/bin/python'} 19:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 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)) 19:25:50 INFO - Cleaning up... 19:25:50 INFO - Return code: 0 19:25:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:25:50 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')]} 19:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:50 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')]} 19:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:50 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:50 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 19:25:50 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 19:25:50 INFO - Using env: {'DISPLAY': ':0', 19:25:50 INFO - 'HOME': '/home/cltbld', 19:25:50 INFO - 'LANG': 'en_US.UTF-8', 19:25:50 INFO - 'LANGUAGE': 'en_US:en', 19:25:50 INFO - 'LOGNAME': 'cltbld', 19:25:50 INFO - 'MAIL': '/var/mail/cltbld', 19:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:50 INFO - 'MOZ_NO_REMOTE': '1', 19:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:50 INFO - 'NO_EM_RESTART': '1', 19:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:50 INFO - 'PWD': '/builds/slave/test', 19:25:50 INFO - 'SHELL': '/bin/bash', 19:25:50 INFO - 'SHLVL': '1', 19:25:50 INFO - 'TERM': 'linux', 19:25:50 INFO - 'TMOUT': '86400', 19:25:50 INFO - 'USER': 'cltbld', 19:25:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:50 INFO - '_': '/tools/buildbot/bin/python'} 19:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:51 INFO - Downloading/unpacking jsonschema 19:25:51 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 19:25:51 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 19:25:51 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 19:25:51 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 19:25:51 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 19:25:51 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 19:25:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:25:52 INFO - Downloading/unpacking functools32 (from jsonschema) 19:25:52 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 19:25:52 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 19:25:52 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 19:25:52 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 19:25:52 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 19:25:52 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 19:25:53 INFO - Downloading functools32-3.2.3-2.tar.gz 19:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:25:53 INFO - warning: no files found matching '*.txt' 19:25:53 INFO - no previously-included directories found matching 'build' 19:25:53 INFO - no previously-included directories found matching 'dist' 19:25:53 INFO - no previously-included directories found matching '.git*' 19:25:53 INFO - Installing collected packages: jsonschema, functools32 19:25:53 INFO - Running setup.py install for functools32 19:25:53 INFO - warning: no files found matching '*.txt' 19:25:53 INFO - no previously-included directories found matching 'build' 19:25:53 INFO - no previously-included directories found matching 'dist' 19:25:53 INFO - no previously-included directories found matching '.git*' 19:25:53 INFO - Successfully installed jsonschema functools32 19:25:53 INFO - Cleaning up... 19:25:53 INFO - Return code: 0 19:25:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:25:53 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')]} 19:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:53 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')]} 19:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:53 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 0x7faef5eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, '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': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', '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 19:25:53 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 19:25:53 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 19:25:53 INFO - Using env: {'DISPLAY': ':0', 19:25:53 INFO - 'HOME': '/home/cltbld', 19:25:53 INFO - 'LANG': 'en_US.UTF-8', 19:25:53 INFO - 'LANGUAGE': 'en_US:en', 19:25:53 INFO - 'LOGNAME': 'cltbld', 19:25:53 INFO - 'MAIL': '/var/mail/cltbld', 19:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:53 INFO - 'MOZ_NO_REMOTE': '1', 19:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:53 INFO - 'NO_EM_RESTART': '1', 19:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:53 INFO - 'PWD': '/builds/slave/test', 19:25:53 INFO - 'SHELL': '/bin/bash', 19:25:53 INFO - 'SHLVL': '1', 19:25:53 INFO - 'TERM': 'linux', 19:25:53 INFO - 'TMOUT': '86400', 19:25:53 INFO - 'USER': 'cltbld', 19:25:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:53 INFO - '_': '/tools/buildbot/bin/python'} 19:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:53 INFO - Downloading/unpacking flake8 19:25:53 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 19:25:53 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 19:25:53 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 19:25:53 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 19:25:53 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 19:25:53 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 19:25:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:25:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:25:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:55 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 19:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:25:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:25:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:25:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:25:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:25:56 INFO - no previously-included directories found matching 'docs/_build' 19:25:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:25:56 INFO - Running setup.py install for pep8 19:25:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:25:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:25:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:25:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:25:56 INFO - no previously-included directories found matching 'docs/_build' 19:25:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:25:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:25:56 INFO - Cleaning up... 19:25:56 INFO - Return code: 0 19:25:56 INFO - Running post-action listener: _resource_record_post_action 19:25:56 INFO - Running post-action listener: _start_resource_monitoring 19:25:56 INFO - Starting resource monitoring. 19:25:56 INFO - ##### 19:25:56 INFO - ##### Finished create-virtualenv step (success) 19:25:56 INFO - ##### 19:25:56 INFO - ##### 19:25:56 INFO - ##### Running install step. 19:25:56 INFO - ##### 19:25:56 INFO - Running pre-action listener: _resource_record_pre_action 19:25:56 INFO - Running main action method: install 19:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:56 INFO - Reading from file tmpfile_stdout 19:25:56 INFO - Detecting whether we're running mozinstall >=1.0... 19:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:25:56 INFO - Reading from file tmpfile_stdout 19:25:56 INFO - Output received: 19:25:56 INFO - Usage: mozinstall [options] installer 19:25:56 INFO - Options: 19:25:56 INFO - -h, --help show this help message and exit 19:25:56 INFO - -d DEST, --destination=DEST 19:25:56 INFO - Directory to install application into. [default: 19:25:56 INFO - "/builds/slave/test"] 19:25:56 INFO - --app=APP Application being installed. [default: firefox] 19:25:56 INFO - mkdir: /builds/slave/test/build/application 19:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:26:12 INFO - Reading from file tmpfile_stdout 19:26:12 INFO - Output received: 19:26:12 INFO - /builds/slave/test/build/application/firefox/firefox 19:26:12 INFO - Running post-action listener: _resource_record_post_action 19:26:12 INFO - ##### 19:26:12 INFO - ##### Finished install step (success) 19:26:12 INFO - ##### 19:26:12 INFO - ##### 19:26:12 INFO - ##### Running run-tests step. 19:26:12 INFO - ##### 19:26:12 INFO - Running pre-action listener: _resource_record_pre_action 19:26:12 INFO - Running main action method: run_tests 19:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:26:12 INFO - Python 2.7.3 19:26:12 INFO - Return code: 0 19:26:12 INFO - grabbing minidump binary from tooltool 19:26:12 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')]} 19:26:12 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca49c0>, '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 0x1ca58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:26:12 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 19:26:12 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 19:26:12 INFO - Calling ['/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'] with output_timeout 600 19:26:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:26:12 INFO - Return code: 0 19:26:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:26:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:26:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:26:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:26:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:26:13 INFO - Return code: 0 19:26:13 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:26:13 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:26:13 INFO - Using env: {'DISPLAY': ':0', 19:26:13 INFO - 'HOME': '/home/cltbld', 19:26:13 INFO - 'LANG': 'en_US.UTF-8', 19:26:13 INFO - 'LANGUAGE': 'en_US:en', 19:26:13 INFO - 'LOGNAME': 'cltbld', 19:26:13 INFO - 'MAIL': '/var/mail/cltbld', 19:26:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:26:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:13 INFO - 'MOZ_NO_REMOTE': '1', 19:26:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:13 INFO - 'NO_EM_RESTART': '1', 19:26:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:13 INFO - 'PWD': '/builds/slave/test', 19:26:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:26:13 INFO - 'SHELL': '/bin/bash', 19:26:13 INFO - 'SHLVL': '1', 19:26:13 INFO - 'TERM': 'linux', 19:26:13 INFO - 'TMOUT': '86400', 19:26:13 INFO - 'USER': 'cltbld', 19:26:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001', 19:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:13 INFO - '_': '/tools/buildbot/bin/python'} 19:26:13 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:26:13 INFO - mozversion application_buildid: 20160510185609 19:26:13 INFO - mozversion application_changeset: 95e7b6e69427410b242d17a2642d2123114c72b7 19:26:13 INFO - mozversion application_display_name: Nightly 19:26:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:26:13 INFO - mozversion application_name: Firefox 19:26:13 INFO - mozversion application_remotingname: firefox 19:26:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:26:13 INFO - mozversion application_vendor: Mozilla 19:26:13 INFO - mozversion application_version: 49.0a1 19:26:13 INFO - mozversion platform_buildid: 20160510185609 19:26:13 INFO - mozversion platform_changeset: 95e7b6e69427410b242d17a2642d2123114c72b7 19:26:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:26:13 INFO - mozversion platform_version: 49.0a1 19:26:13 INFO - using testdate: 1462933573 19:26:13 INFO - actual date: 1462933573 19:26:13 INFO - starting webserver on 'localhost:44182' 19:26:13 INFO - SUITE-START | Running 2 tests 19:26:13 INFO - TEST-START | dromaeo_css 19:26:13 INFO - operating with platform_type : linux_ 19:26:13 INFO - Initialising browser for dromaeo_css test... 19:26:13 INFO - TEST-INFO | started process 11582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAX5Iib/profile http://localhost:44182/getInfo.html) 19:26:17 INFO - PROCESS | 11582 | __metrics Screen width/height:1600/1200 19:26:17 INFO - PROCESS | 11582 | colorDepth:24 19:26:17 INFO - PROCESS | 11582 | Browser inner width/height: 1024/697 19:26:17 INFO - PROCESS | 11582 | __metrics 19:26:18 ERROR - PROCESS | 11582 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:26:19 INFO - TEST-INFO | 11582: exit 0 19:26:19 INFO - Browser initialized. 19:26:19 INFO - Running cycle 1/1 for dromaeo_css test... 19:26:19 INFO - TEST-INFO | started process 11662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAX5Iib/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:31 INFO - PROCESS | 11662 | RSS: Main: 153767936 19:26:31 INFO - PROCESS | 11662 | 19:27:22 INFO - PROCESS | 11662 | 1462933642807 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] 19:29:34 INFO - PROCESS | 11662 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44182/tests/dromaeo/cssquery-ext.html) 19:29:35 INFO - PROCESS | 11662 | RSS: Main: 267313152 19:29:35 INFO - PROCESS | 11662 | 19:32:38 INFO - PROCESS | 11662 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-ext.html (next: http://localhost:44182/tests/dromaeo/cssquery-jquery.html) 19:32:38 INFO - PROCESS | 11662 | RSS: Main: 242135040 19:32:38 INFO - PROCESS | 11662 | 19:35:41 INFO - PROCESS | 11662 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44182/tests/dromaeo/cssquery-mootools.html) 19:35:41 INFO - PROCESS | 11662 | RSS: Main: 247263232 19:35:41 INFO - PROCESS | 11662 | 19:38:43 INFO - PROCESS | 11662 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44182/tests/dromaeo/cssquery-prototype.html) 19:38:44 INFO - PROCESS | 11662 | RSS: Main: 236277760 19:38:44 INFO - PROCESS | 11662 | 19:41:47 INFO - PROCESS | 11662 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44182/tests/dromaeo/cssquery-yui.html) 19:41:47 INFO - PROCESS | 11662 | RSS: Main: 213823488 19:41:47 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-yui.html (next: http://localhost:44182/tests/dromaeo/cssquery-dojo.html) 19:44:50 INFO - PROCESS | 11662 | RSS: Main: 279851008 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | __start_tp_report 19:44:50 INFO - PROCESS | 11662 | _x_x_mozilla_page_load 19:44:50 INFO - PROCESS | 11662 | _x_x_mozilla_page_load_details 19:44:50 INFO - PROCESS | 11662 | |i|pagename|runs| 19:44:50 INFO - PROCESS | 11662 | |0;dojo.html;2649.2714503511543;2654.920352389428;2686.4627074585087;2707.8239914405563;2722.1697382298403;4662.533746625344;4667.4399072111355;4725.551072648102;4794.376731024966;4796.784144713483;4623.514530974249;4653.046125544255;4656.534346565341;4680.5787479126875;4711.882202944928;4246.787660616972;4289.378040184171;4318.719283246594;4350.630196433307;4564.9087018259615;4474.709143905636;4491.663125265618;4502.122086193193;4532.048269863316;4553.704009239405;4264.87205383839;4285.3786201000685;4311.698181127323;4339.891502712426;4360.498542667587;4359.455068116486;4370.584794444522;4371.737695738234;4377.146456440995;4467.664925130595;4385.539518350559;4399.912001759979;4411.933820992687;4447.421835161441;4459.665525085632;4507.774611269423;4648.233041548175;4692.343071969927;4728.905421891577;4775.997040621473;5123.923141152885;5156.535911767922;5170.715610641413;5173;5176.5858731301405;5161.354830646169;5162.457941916082;5182.896342073137;5201.219817027476;5208.791648334062;4684.039771846763;4759.16714574948;4798.3042458843975;4799.0641824844515;4858.246971719389;5269.341332333458;5278.392984806719;5290.761915713802;5292.9735351323;5297.443768404262;5052.621053421009;5088.338515992898;5097.260897169889;5105.719185444762;5106.974465127651;5003.049420610072;5118.360204974379;5175.327207463081;5175.637705360588;5254.500822421864;5147.433782283946;5155.74221288934;5156.664816786897;5162.716050617177;5178.093833579184;5130.48695130484;5139.434662187231;5150.175971844487;5158.8968220636125;5201.713905735221;4264.6801489888385;4296.291111966553;4323.027318853233;4340.066885619607;4394.209042372339;3762.9059273518383;3774.5281839770028;3776.1692427666417;3802.0114770159403;3821.6560509554274;4303.33298338758;4307.698461107755;4309.719868208556;4346.500152482442;4355.259605867011;4961;4963.429205641325;4973.776180071905;5046.470120637354;5074.4671809460215;4229.577042295808;4237.406763053175;4240.109576988867;4252.510961239497;4291.0130669945465;4516.1419330327135;4528.0943811237885;4531.093781243764;4571.885702857455;4576.290674945389;4676.883077923079;4796.016816552528;4842.854714358434;4862.294967229661;4877.9024419512125;5148.176291793295;5173.22401639757;5193.7403129844115;5195.636305458582;5268.341457317835;4669.9533004670875;4693.741844198602;4699.4830568636735;4704.411948506437;4712.646551508582;4996.275540046746;5002.874928126826;5039.798408063636;5087.64386492942;5105.540501354896;5120.795168193231;5137.717425541481;5138.948610513847;5139.383274007143;5160.148575485003;4983.451820299837;4984.327115839315;4987.102321582005;4987.301777751045;5019.924701129413;4878.243872199815;4964.156093464047;5013;5016.924746128884;5053.26727624485;4950.356453661001;4962.082014827124;4965.30485732005;4997.675151115166;5001.549860512571;4786.210275304536;5062.392512898476;5073.797048118034;5098.694078355311;5116.07910576085;4677.298405239241;4691.202495575692;4704.764761761967;4704.976475117603;4708.199606066908 19:44:50 INFO - PROCESS | 11662 | |1;ext.html;563.0372063770951;598.7485256192399;599.6581948289477;601.6630686815382;620.2618883528602;27577.31056723583;41817;42609.57390426095;42707.572924270746;42773.14453710928;41766.37350439746;42378.364324535156;42437.57562424375;42441.15117697644;42469.575304247024;7900.170482099368;8029.638666260033;8036.557989310586;8040;8044.115147333789;7716.035495563055;7764;7773.961130194341;7819;7822.374210063182;7756.340711039568;7819.687212511492;7881.09367422748;7893.171217022216;7899.9210007899765;7742.806429839299;7755.340796032344;7776.183500732426;7800.570968596753;7856.882146767803;7813.2577405146985;7853.685852565891;7859.37125030002;7865.9606701966695;7875.76372708814;39576.40635390471;39848.40227396591;39937;39973.80013099945;40003.7999810002;3053.4351145038017;3150.6691797361404;3238.3199528099126;3250.9187270318193;3683.4843121962945;28600.856995715098;30716.2320941976;30976.225594360098;30986.225344366347;31002.0699379019;3051.6032915721034;3136.8902088427026;3169.4611915974338;3188.6333071696818;3326.5841769778776;251437;251590;253718;253726.73136634383;253754;58005.70997144987;59150;59445.405545943984;59446.70276648589;59514;53662.195067074026;61947.38052619506;63841;63876.68061659755;69093.65453172702;14179.291035448186;14214.857851421353;14244.786328205086;14275.857241427453;14347.56957291283;10822.78354432907;10951.34291942486;10993.505292261867;11011.669649910515;11042.889571104346;19053.523661908286;19530.915144084687;20125.698114528295;20349.694754578693;20473.590528189354;7241.2396698346965;7262.927370726331;7356.558606483628;7412.85174296511;7586.810329741801;862.2843040276556;899.4738078224312;941.4163218804248;959.3524371049654;1030.7680771826429;27965.72034279631;28959.276018099295;29087.56368654472;29271.560926586117;29290.85354573256;1000.849872519128;1036.5180191211123;1131.2759833706434;1137.6643890052455;1140.2702270546856;15321.616959575877;15396.384144634314;15589.454369097028;15751.606209844846;15806.288717007763;338787;340932;342876;343512;344308;33226.50160247598;33538.66461335404;33722.15694607605;33759.15602109967;33762.662373375955;1165.8950694437542;1290.4064130499887;1308.685915380321;1321.1478596305328;1324.675454513631;29256.7074329254;29269.41461170807;30323.574114071263;30511.54232686467;30731.846340768152;44772.418206542745;49801;50406;50414.49585504245;50480.49519504905;331527;332184;332241;333445;335316;34609;35777.46333805047;43153;44178.779106104266;44688.77655611701;43511.78244108759;44256.778716106215;45604.771976139906;45822.31266530938;46007.53992460033;36277.637223627426;37900.2419951605;37936.62063379331;37985.43021854619;38000;36687.26625467529;37215.25569488541;37869;37889;38176;36008;36178;36641.633583663825;37017;37122.14389280579;31412.52881206738;33193.336133277684;33625.66374336225;35173.47239791354;35194.64805352016;25626.359341016625;25977.610335844598;26276.42630313736;26354.472910542067;26550 19:44:50 INFO - PROCESS | 11662 | |2;jquery.html;371.5040421037913;382.5390404562502;390.9863154789582;392.0121294338266;404.7571457125723;16787.41244056458;17123.74314385285;17779.111044447774;17854.55363615907;17855.19651615677;16892.662146757088;17369.305227790872;17398.304067837304;17642.117894105308;17678;4929.235968424891;5047.596192304625;5086.211637196222;5115.360579927509;5131.666441681279;3664.9450258246147;3875.2249550090096;5656.886862262752;5960.612560183574;5974.731137098841;5989.431004054608;6016.127661489081;6016.578839481238;6021.879562408749;6022.608530445529;5705.800296989606;5811.418858114154;5822.592418530705;5998.790042348519;6051.727672254737;3391.8643254270046;4980.526849949249;5298.788048478056;5307.575393968474;5392.622516423852;19868.80131198684;20187.697184542245;20194.091265892923;20570.280040198522;21014.684779728315;1931.8164774346415;1965.6068786242665;2013.8993050347572;2039.3983774786473;2104.431803413085;13011;13108.47566097355;13121.47514099435;13138.146020508731;13368.39842207103;1789.7046987247088;1809.1135343681633;1826.0869565217392;1831.8534517238722;1878.9436316910515;66756;67863;68203;68726.65636671835;68758.65620671865;9391.389559678599;9422.481763502936;9706;9815.312928095107;9850.162736167362;13684.52104176369;13813.585592432242;13827.239501827496;13830.441368346888;13865.722685546232;7157.997880296763;7186.784396468114;7249.8550028999125;7378.704851805975;7391.889121663179;6974;6986.196587392414;7037.190723066913;7131.393831524275;7232.204457509775;6134.877302453926;6149.292831324366;6216.906746398808;6221.720022598994;6242.563020588606;1621.6675581505763;1738.6696527659703;1827.2682339901933;1830.381958230759;1854.7125195594704;916.0701887584107;982.7346616413529;983.4148681534618;1007.0433088565745;1035.7048241251207;16012.839871601134;16885.831141688424;17051.403200887908;17121.315147393965;17378.39175628847;954.9809003820023;955.1928620315822;955.5652178258875;959.8176346494143;968.5931908598405;9823.263255255884;9976.201903847676;10081.798364032826;10102.69691909244;10112.292139550162;413313;422399;422867;440381;446537;83833.58083209668;84835.57582212049;87107;88362.11637883539;89112.5544372274;946.2666433514082;967.8161149381594;968.5738275158908;985.6944347252374;992.5235886774389;15278.159701216095;15594.298256578708;15782.131982741059;15808.683826323639;15982.200889955688;36475.817620912785;36946.63053369432;36965.630343697296;37863.43204851874;38330;50445.49554504408;50883.2367514495;51955;52066.21900671417;52648;7587.886181707389;7724.266194711493;7737.845243095219;7781.103035485331;7997.680092796223;8692.782680432787;10900.672979810619;11733.296002239893;12014.75970480568;12129.69675758113;9846.519833475895;10046.196304295492;10096.444695541815;10230.130438912776;10547.388550257181;10164.644237451654;10420.635277765241;10424.478776061014;10428.426436546062;10503.632372866912;9755.658551950648;9845.360051596623;10168.74578135523;10325.070743633109;10360.171186305228;7653.57905315213;7799.49303295284;7857.960710196412;7893.605319734105;7948.761537153895;9662.806743865223;9663.661771837951;9732.464714440774;10109.545070471699;10377.792444150924 19:44:50 INFO - PROCESS | 11662 | |3;mootools.html;1309.574388323795;1467.310364128859;1532.9463468778592;1725.2064050536753;1886.3020682347526;6591.274959754423;7626.428017898659;7884.566348850811;7888.368930485562;8092.10986791454;7845.176256493071;8020.759377218678;8021.237982391678;8028.3978701597325;8031.799205019877;2220.822334213267;2248.1457046322375;2252.88735563222;2254.1434254983083;2255.458689914417;2203.867767933921;2206.3822129803602;2271.7728227177317;2273.829462790289;2274.7611500792427;2201.9449513762124;2214.745304290003;2230.520438105815;2231.0183519251477;2242.9775702242932;2120.4274845791706;2145.3349461666853;2154.1706443019393;2154.741431028271;2158.4388059104667;2130.9558316424996;2138.379869837745;2142.4429648291402;2143.057054895841;2145.978540214609;7684.538927664358;7905.762827115196;7918.049834019955;8049.879251811228;8050.718224862102;4906.852794416173;4966.354373931402;5010.398752149729;5018.723970181639;5025.623078269108;2878.1506308754183;2946.175070980129;2949.5133303004977;2975.375171214026;3015.72858442739;873.9606717697719;887.8623813308948;888.1118881118881;889.3241136736127;906.8549032154824;10678.679639610824;10783.730406739816;10799.946000270027;10818.08046316064;10838.891611083867;4163.375493675912;4273.850415235452;4326.58897404746;4363.061941682554;4366.19225443294;8704.390692651454;8706.695265665798;8711.869321960176;8731.170538798804;8741.562921853882;4718.05638872227;4724.126036683225;4725.881852953704;4735.810567577259;4736.360591320196;3823.101571130838;4178.811953462102;4293.677974151951;4340.739555626673;4509.594136527663;3419.555457790521;3427.845746941394;3520.735944804099;3522.2075033117344;3522.682958533693;1007.0734923870057;1020.5917632946732;1024.5440778853488;1025.3642741500319;1035.7410647338165;916.5371487398821;919.8022425178618;923.0677016213673;949.6913503111516;950.9857352139724;5516.9448305516435;5757.942420575824;5814.796482123105;5828.184054232411;5936.495397891142;890.4790697441939;894.9552522373855;933.6638810028385;950.6862735297335;961.8845738511424;3767.246550689873;3820.1977584707524;3874.767513949172;3931.0761970936805;3975.860844870416;9175.862362064574;9927.702168934944;9972.501374931224;9990.40057596532;10001.399916005063;9566.760830979141;9663.46850923206;9908.256880733974;9923.503824808731;9936.50317484123;7400.481966262418;7634.274743899321;7687.923690683308;7703.6918523259565;7755;5409.107497262908;5444.972775136099;5505.504504594605;5590.105583106683;5622.9718851407115;8590.398672093144;8787.34094942869;9323.766905827137;9359.766005849908;9404.294677899321;9151.17639412456;9192.17270445663;9329.766755831159;9369.953150234205;9449.102335278138;6235.657038862906;6834.1457317835275;6906.965465172642;6995.8251043722275;7054.823629409306;7581.3176814087;7607.239276072349;7676.846463070596;7678.424118191047;7697.6151192441275;6980.441564674916;7126.928730712834;7133.964330178316;7236.276372362932;7252.673629686782;6880;6928.792136235921;7031.929680703128;7054.4003759681;7073.575585464889;6234.127222188988;6523.412892839668;6538.607683539003;6608.768693095719;6694.564853284521;4775.904481910412;4849.975750121227;4857.392825896763;4862.3922009748785;4902.362692849907;4972.2790195422185;4985.875353116056;5019.551868206975;5047.545720885138;5075.441701412916 19:44:50 INFO - PROCESS | 11662 | |4;prototype.html;315.6590881847605;317.72675499070795;321.42625413636665;325.5702472735988;325.6661921530431;4781.18719817631;4791.257355109963;4793.808247670094;4796.232602783555;4817.518248175181;4707.599854012413;4719.504452032538;4735.479097299294;4741.336212930192;4749.311349854269;3580.409232476645;3602.7478076534653;3702.426123950792;3714.7956862372557;3777.0368556018175;3744.9625503744887;3760.680342170905;3775.1505911170043;3779.9622003780023;3807.257584770971;3564.2515071834946;3766.886993390203;3772.5850156482766;3772.8868133956025;3799.3161230978412;3600.1539638185004;3703.777773333609;3727.1178055082282;3727.925441491182;3738.981305093457;3278.4590542560686;3296.9175770605925;3297.76915615907;3299.5050742388594;3312.1554003728893;4505.932411013838;4514.841980530666;4527.7283362998;4528.094381123756;4534.344964088117;3976.8210430530694;4222.577742225783;4249.723767955073;4259.488861336628;4279.700420970534;4911.140550403665;4920.876978075541;4940.6788558743565;4952.232403977389;4952.851414457572;3517.208628058692;3554.2713743682743;3580.6419358064245;3590.335787879251;3600.819959002066;5022.824201152942;5165.74171291434;5188.481151884819;5199.48005199477;5203.089459344599;3637.654422829827;3643.599204087548;3653.8173091345857;3657.2868290683064;3659.5425571803526;3694.907627309285;3697.8890633281044;3699.8335074921692;3701.9074523137137;3706.2772759312215;4194.916101678011;4199.790010499462;4206.642435392964;4220.134872351161;4225.830966761357;4865.197242455026;4936.950630493721;4948.490710333383;4969.229769385751;4977.626677999092;1269.7333559952513;1275.2603489975793;1277.8530468995998;1290.6386211860695;1291.599604122706;813.983720325602;830.3606223208217;852.6205838401852;868.847951608466;868.8522951098329;4265.274903266452;4290.957090429056;4309.202797482476;4317.438732964694;4325.653947684178;4980.850574482772;4986.80052797884;4995.450500444948;5066.392032956069;5077.314562534085;4149.937750933738;4267.0825772459075;4268.722533035343;4292.248856450109;4320.524742278347;2692.6095716121054;2706.648135742341;2712.6744790625253;2715.823471474348;2719.2386131883104;4706.152892479318;4727.125481785881;4748.810047598126;4806.9570432566015;4844.685095468783;4972.975135124301;4990.674641456054;5099.413567439792;5195.6622819516615;5200.869978250574;4717.8112875485285;4760;4765.594924431392;4768.284757286435;4774.3315935769715;5022.974885125551;5032.295478633067;5044.369453818273;5068.873278167928;5085.618578606545;4730.290456431563;4853.174960256835;4899.485554016777;4901.779419926183;4927.975360123177;4705.364775755229;4710.4347478302825;4719.433667959866;4740.7910982699195;4746.477887432448;3619;3634.545681789776;3635.8000309983204;3636.1091532574687;3645.1433913030946;4822.493638167942;4885.900672348693;5022.221555658879;5033.899322013613;5065.39215294167;4819.903601928012;4823;4824.155772739687;4832.44426890912;4835.975820120877;4819.204831202953;4832.420109586872;4844.660873738945;4868.853934381974;4873.905070280327;4559.794809233659;4726.621870250303;4742.66801323904;4770.117528257283;4780.211265141213;4914.533119353656;4959.20652695567;4990.3762029746285;5009.148444764326;5027.446980832033;4852.927206091982;4856.732879691651;4866.829660961849;4900.705957642553;4932 19:44:50 INFO - PROCESS | 11662 | |5;yui.html;695.8121307247044;728.2499026003219;728.9198188199297;760.9726868727219;785.3285440947985;11786.587469438571;12142.089343299265;12188;12228.694282642939;12231.938840305796;11036.11711063115;11343.829842552368;11523.48144333505;11523.654290371282;11558.653240402802;693.9687714052855;833.9332853371747;859.6604341285189;865.2299453486387;883.4919921045392;860.7761981884723;861.2636196052379;863.8056437301619;863.952482613456;864.4597126795753;907.3829795738895;907.9409838360485;909.3316412436853;909.4997751236826;909.5361365703505;718.7484380466847;887.671561522241;897.2597606974273;897.7531178925848;906.9093090690944;641.7529251238307;641.9133416988693;642;642.0689999500743;647.6761619190405;11635.650930472098;11677.766444671059;11680.415979201007;11685.298882067103;11692.707682307926;10996.945015274872;11434.656960291122;11485.483153258123;11537.192396532246;11736.765264694744;10407.167426605929;10758.946205269001;10874.18443616724;11056.281341712844;11373.147013973985;4032.717709760318;4059.9594004059877;4090.7341022833716;4144.937825932613;4153.646940010103;42258.57741422577;42355.7882210587;45241.77379113116;45255;45291.320630190574;9491.38306010107;9729;9948.651797187063;10366.688999330032;10373.740656483647;17884.195211215527;17989.280428782702;18000;18047.278108875762;18070.548236293936;5584.357798853102;5649.096144616841;5659.3208814941645;5776.555861034742;5787.797427090031;3565.4830049643174;3617.764845285048;3638.9818050910108;3695.6858667013066;3755.3052685253315;2618.423946731716;2692.0577797771016;2692.151972128773;2693.8922443102056;2699.1227850948126;467.18243074619414;494.85896519491774;507.9568236699922;514.7426286856572;515.8426679862678;551.2640624765902;576.4034224577542;651.9282878883319;654.1104098426136;677.2144312597363;8257.174282571816;8290.295324897452;8358.958205208935;8451.492910425393;8511.148885111439;538.8221886777354;562.4656576252495;573.0430181596744;583.6060659055206;587.2952457051555;3837.597052309523;3896.8246428910766;3941.7043721720984;4021.2158629067053;4118.588141185857;48478.27282590764;49026.75486622544;49900.50099498958;50246.748766255936;50405;44757;45640.771796140805;45875.77062114668;45928.3110753339;46170.76914615405;40555.59444405518;41448.79275603663;41721.79139104285;42046.57953420427;42680;7803.843923121619;7841.294283514511;7962.641681124479;7964.20357964199;8114.175113736312;28374;29066.854665726536;29170.562441562968;29299.560506592843;29674.851625741732;33819.32361352808;35197.82401087978;36682.26635467329;36737.22416085892;36989.44515832211;10007.449590272605;10067.446290454096;10154.339967902062;10385.169186465217;10654.254202205771;10687.946560267148;10697.197710171613;11125.221234513507;11231.606893758679;11619.88380116222;10314.381137131797;10506.212034097625;10595.523201455799;11037.392943388191;11155.776884462428;10009.949950250202;10227.232957528066;10305.124064454305;10408.531616077144;10720.67837964831;10355.637552685619;10373.481325933522;10825.837612435662;10844.457777110954;10878.945605271923;8383.245507904317;8497.532635705096;8663.870041949502;8861.822763544564;8899.599518021576;9099.590518426554;9224.529155337741;9239.168474837297;9309.255259579082;9371.953140234255 19:44:50 INFO - PROCESS | 11662 | __end_tp_report 19:44:50 INFO - PROCESS | 11662 | __start_cc_report 19:44:50 INFO - PROCESS | 11662 | _x_x_mozilla_cycle_collect,1048 19:44:50 INFO - PROCESS | 11662 | __end_cc_report 19:44:50 INFO - PROCESS | 11662 | __startTimestamp1462934690952__endTimestamp 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | ------- Summary: start ------- 19:44:50 INFO - PROCESS | 11662 | Number of tests: 6 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | [#0] dojo.html Cycles:165 Average:4712.08 Median:4794.38 stddev:510.25 (10.6%) stddev-sans-first:485.47 19:44:50 INFO - PROCESS | 11662 | Values: 2649.3 2654.9 2686.5 2707.8 2722.2 4662.5 4667.4 4725.6 4794.4 4796.8 4623.5 4653.0 4656.5 4680.6 4711.9 4246.8 4289.4 4318.7 4350.6 4564.9 4474.7 4491.7 4502.1 4532.0 4553.7 4264.9 4285.4 4311.7 4339.9 4360.5 4359.5 4370.6 4371.7 4377.1 4467.7 4385.5 4399.9 4411.9 4447.4 4459.7 4507.8 4648.2 4692.3 4728.9 4776.0 5123.9 5156.5 5170.7 5173.0 5176.6 5161.4 5162.5 5182.9 5201.2 5208.8 4684.0 4759.2 4798.3 4799.1 4858.2 5269.3 5278.4 5290.8 5293.0 5297.4 5052.6 5088.3 5097.3 5105.7 5107.0 5003.0 5118.4 5175.3 5175.6 5254.5 5147.4 5155.7 5156.7 5162.7 5178.1 5130.5 5139.4 5150.2 5158.9 5201.7 4264.7 4296.3 4323.0 4340.1 4394.2 3762.9 3774.5 3776.2 3802.0 3821.7 4303.3 4307.7 4309.7 4346.5 4355.3 4961.0 4963.4 4973.8 5046.5 5074.5 4229.6 4237.4 4240.1 4252.5 4291.0 4516.1 4528.1 4531.1 4571.9 4576.3 4676.9 4796.0 4842.9 4862.3 4877.9 5148.2 5173.2 5193.7 5195.6 5268.3 4670.0 4693.7 4699.5 4704.4 4712.6 4996.3 5002.9 5039.8 5087.6 5105.5 5120.8 5137.7 5138.9 5139.4 5160.1 4983.5 4984.3 4987.1 4987.3 5019.9 4878.2 4964.2 5013.0 5016.9 5053.3 4950.4 4962.1 4965.3 4997.7 5001.5 4786.2 5062.4 5073.8 5098.7 5116.1 4677.3 4691.2 4704.8 4705.0 4708.2 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | [#1] ext.html Cycles:180 Average:47727.27 Median:36459.64 stddev:81783.46 (224.3%) stddev-sans-first:81936.22 19:44:50 INFO - PROCESS | 11662 | Values: 563.0 598.7 599.7 601.7 620.3 27577.3 41817.0 42609.6 42707.6 42773.1 41766.4 42378.4 42437.6 42441.2 42469.6 7900.2 8029.6 8036.6 8040.0 8044.1 7716.0 7764.0 7774.0 7819.0 7822.4 7756.3 7819.7 7881.1 7893.2 7899.9 7742.8 7755.3 7776.2 7800.6 7856.9 7813.3 7853.7 7859.4 7866.0 7875.8 39576.4 39848.4 39937.0 39973.8 40003.8 3053.4 3150.7 3238.3 3250.9 3683.5 28600.9 30716.2 30976.2 30986.2 31002.1 3051.6 3136.9 3169.5 3188.6 3326.6 251437.0 251590.0 253718.0 253726.7 253754.0 58005.7 59150.0 59445.4 59446.7 59514.0 53662.2 61947.4 63841.0 63876.7 69093.7 14179.3 14214.9 14244.8 14275.9 14347.6 10822.8 10951.3 10993.5 11011.7 11042.9 19053.5 19530.9 20125.7 20349.7 20473.6 7241.2 7262.9 7356.6 7412.9 7586.8 862.3 899.5 941.4 959.4 1030.8 27965.7 28959.3 29087.6 29271.6 29290.9 1000.8 1036.5 1131.3 1137.7 1140.3 15321.6 15396.4 15589.5 15751.6 15806.3 338787.0 340932.0 342876.0 343512.0 344308.0 33226.5 33538.7 33722.2 33759.2 33762.7 1165.9 1290.4 1308.7 1321.1 1324.7 29256.7 29269.4 30323.6 30511.5 30731.8 44772.4 49801.0 50406.0 50414.5 50480.5 331527.0 332184.0 332241.0 333445.0 335316.0 34609.0 35777.5 43153.0 44178.8 44688.8 43511.8 44256.8 45604.8 45822.3 46007.5 36277.6 37900.2 37936.6 37985.4 38000.0 36687.3 37215.3 37869.0 37889.0 38176.0 36008.0 36178.0 36641.6 37017.0 37122.1 31412.5 33193.3 33625.7 35173.5 35194.6 25626.4 25977.6 26276.4 26354.5 26550.0 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | [#2] jquery.html Cycles:180 Average:25852.82 Median:225733.12 stddev:70807.52 (31.4%) stddev-sans-first:70980.30 19:44:50 INFO - PROCESS | 11662 | Values: 371.5 382.5 391.0 392.0 404.8 16787.4 17123.7 17779.1 17854.6 17855.2 16892.7 17369.3 17398.3 17642.1 17678.0 4929.2 5047.6 5086.2 5115.4 5131.7 3664.9 3875.2 5656.9 5960.6 5974.7 5989.4 6016.1 6016.6 6021.9 6022.6 5705.8 5811.4 5822.6 5998.8 6051.7 3391.9 4980.5 5298.8 5307.6 5392.6 19868.8 20187.7 20194.1 20570.3 21014.7 1931.8 1965.6 2013.9 2039.4 2104.4 13011.0 13108.5 13121.5 13138.1 13368.4 1789.7 1809.1 1826.1 1831.9 1878.9 66756.0 67863.0 68203.0 68726.7 68758.7 9391.4 9422.5 9706.0 9815.3 9850.2 13684.5 13813.6 13827.2 13830.4 13865.7 7158.0 7186.8 7249.9 7378.7 7391.9 6974.0 6986.2 7037.2 7131.4 7232.2 6134.9 6149.3 6216.9 6221.7 6242.6 1621.7 1738.7 1827.3 1830.4 1854.7 916.1 982.7 983.4 1007.0 1035.7 16012.8 16885.8 17051.4 17121.3 17378.4 955.0 955.2 955.6 959.8 968.6 9823.3 9976.2 10081.8 10102.7 10112.3 413313.0 422399.0 422867.0 440381.0 446537.0 83833.6 84835.6 87107.0 88362.1 89112.6 946.3 967.8 968.6 985.7 992.5 15278.2 15594.3 15782.1 15808.7 15982.2 36475.8 36946.6 36965.6 37863.4 38330.0 50445.5 50883.2 51955.0 52066.2 52648.0 7587.9 7724.3 7737.8 7781.1 7997.7 8692.8 10900.7 11733.3 12014.8 12129.7 9846.5 10046.2 10096.4 10230.1 10547.4 10164.6 10420.6 10424.5 10428.4 10503.6 9755.7 9845.4 10168.7 10325.1 10360.2 7653.6 7799.5 7858.0 7893.6 7948.8 9662.8 9663.7 9732.5 10109.5 10377.8 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | [#3] mootools.html Cycles:180 Average:5273.59 Median:5606.54 stddev:2922.82 (52.1%) stddev-sans-first:2915.84 19:44:50 INFO - PROCESS | 11662 | Values: 1309.6 1467.3 1532.9 1725.2 1886.3 6591.3 7626.4 7884.6 7888.4 8092.1 7845.2 8020.8 8021.2 8028.4 8031.8 2220.8 2248.1 2252.9 2254.1 2255.5 2203.9 2206.4 2271.8 2273.8 2274.8 2201.9 2214.7 2230.5 2231.0 2243.0 2120.4 2145.3 2154.2 2154.7 2158.4 2131.0 2138.4 2142.4 2143.1 2146.0 7684.5 7905.8 7918.0 8049.9 8050.7 4906.9 4966.4 5010.4 5018.7 5025.6 2878.2 2946.2 2949.5 2975.4 3015.7 874.0 887.9 888.1 889.3 906.9 10678.7 10783.7 10799.9 10818.1 10838.9 4163.4 4273.9 4326.6 4363.1 4366.2 8704.4 8706.7 8711.9 8731.2 8741.6 4718.1 4724.1 4725.9 4735.8 4736.4 3823.1 4178.8 4293.7 4340.7 4509.6 3419.6 3427.8 3520.7 3522.2 3522.7 1007.1 1020.6 1024.5 1025.4 1035.7 916.5 919.8 923.1 949.7 951.0 5516.9 5757.9 5814.8 5828.2 5936.5 890.5 895.0 933.7 950.7 961.9 3767.2 3820.2 3874.8 3931.1 3975.9 9175.9 9927.7 9972.5 9990.4 10001.4 9566.8 9663.5 9908.3 9923.5 9936.5 7400.5 7634.3 7687.9 7703.7 7755.0 5409.1 5445.0 5505.5 5590.1 5623.0 8590.4 8787.3 9323.8 9359.8 9404.3 9151.2 9192.2 9329.8 9370.0 9449.1 6235.7 6834.1 6907.0 6995.8 7054.8 7581.3 7607.2 7676.8 7678.4 7697.6 6980.4 7126.9 7134.0 7236.3 7252.7 6880.0 6928.8 7031.9 7054.4 7073.6 6234.1 6523.4 6538.6 6608.8 6694.6 4775.9 4850.0 4857.4 4862.4 4902.4 4972.3 4985.9 5019.6 5047.5 5075.4 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | [#4] prototype.html Cycles:180 Average:4095.41 Median:4718.62 stddev:1167.07 (24.7%) stddev-sans-first:1135.33 19:44:50 INFO - PROCESS | 11662 | Values: 315.7 317.7 321.4 325.6 325.7 4781.2 4791.3 4793.8 4796.2 4817.5 4707.6 4719.5 4735.5 4741.3 4749.3 3580.4 3602.7 3702.4 3714.8 3777.0 3745.0 3760.7 3775.2 3780.0 3807.3 3564.3 3766.9 3772.6 3772.9 3799.3 3600.2 3703.8 3727.1 3727.9 3739.0 3278.5 3296.9 3297.8 3299.5 3312.2 4505.9 4514.8 4527.7 4528.1 4534.3 3976.8 4222.6 4249.7 4259.5 4279.7 4911.1 4920.9 4940.7 4952.2 4952.9 3517.2 3554.3 3580.6 3590.3 3600.8 5022.8 5165.7 5188.5 5199.5 5203.1 3637.7 3643.6 3653.8 3657.3 3659.5 3694.9 3697.9 3699.8 3701.9 3706.3 4194.9 4199.8 4206.6 4220.1 4225.8 4865.2 4937.0 4948.5 4969.2 4977.6 1269.7 1275.3 1277.9 1290.6 1291.6 814.0 830.4 852.6 868.8 868.9 4265.3 4291.0 4309.2 4317.4 4325.7 4980.9 4986.8 4995.5 5066.4 5077.3 4149.9 4267.1 4268.7 4292.2 4320.5 2692.6 2706.6 2712.7 2715.8 2719.2 4706.2 4727.1 4748.8 4807.0 4844.7 4973.0 4990.7 5099.4 5195.7 5200.9 4717.8 4760.0 4765.6 4768.3 4774.3 5023.0 5032.3 5044.4 5068.9 5085.6 4730.3 4853.2 4899.5 4901.8 4928.0 4705.4 4710.4 4719.4 4740.8 4746.5 3619.0 3634.5 3635.8 3636.1 3645.1 4822.5 4885.9 5022.2 5033.9 5065.4 4819.9 4823.0 4824.2 4832.4 4836.0 4819.2 4832.4 4844.7 4868.9 4873.9 4559.8 4726.6 4742.7 4770.1 4780.2 4914.5 4959.2 4990.4 5009.1 5027.4 4852.9 4856.7 4866.8 4900.7 4932.0 19:44:50 INFO - PROCESS | 11662 | 19:44:50 INFO - PROCESS | 11662 | [#5] yui.html Cycles:180 Average:12373.26 Median:42152.58 stddev:13874.61 (32.9%) stddev-sans-first:13885.82 19:44:50 INFO - PROCESS | 11662 | Values: 695.8 728.2 728.9 761.0 785.3 11786.6 12142.1 12188.0 12228.7 12231.9 11036.1 11343.8 11523.5 11523.7 11558.7 694.0 833.9 859.7 865.2 883.5 860.8 861.3 863.8 864.0 864.5 907.4 907.9 909.3 909.5 909.5 718.7 887.7 897.3 897.8 906.9 641.8 641.9 642.0 642.1 647.7 11635.7 11677.8 11680.4 11685.3 11692.7 10996.9 11434.7 11485.5 11537.2 11736.8 10407.2 10758.9 10874.2 11056.3 11373.1 4032.7 4060.0 4090.7 4144.9 4153.6 42258.6 42355.8 45241.8 45255.0 45291.3 9491.4 9729.0 9948.7 10366.7 10373.7 17884.2 17989.3 18000.0 18047.3 18070.5 5584.4 5649.1 5659.3 5776.6 5787.8 3565.5 3617.8 3639.0 3695.7 3755.3 2618.4 2692.1 2692.2 2693.9 2699.1 467.2 494.9 508.0 514.7 515.8 551.3 576.4 651.9 654.1 677.2 8257.2 8290.3 8359.0 8451.5 8511.1 538.8 562.5 573.0 583.6 587.3 3837.6 3896.8 3941.7 4021.2 4118.6 48478.3 49026.8 49900.5 50246.7 50405.0 44757.0 45640.8 45875.8 45928.3 46170.8 40555.6 41448.8 41721.8 42046.6 42680.0 7803.8 7841.3 7962.6 7964.2 8114.2 28374.0 29066.9 29170.6 29299.6 29674.9 33819.3 35197.8 36682.3 36737.2 36989.4 10007.4 10067.4 10154.3 10385.2 10654.3 10687.9 10697.2 11125.2 11231.6 11619.9 10314.4 10506.2 10595.5 11037.4 11155.8 10009.9 10227.2 10305.1 10408.5 10720.7 10355.6 10373.5 10825.8 10844.5 10878.9 8383.2 8497.5 8663.9 8861.8 8899.6 9099.6 9224.5 9239.2 9309.3 9372.0 19:44:50 INFO - PROCESS | 11662 | -------- Summary: end -------- 19:44:50 INFO - PROCESS | 11662 | 19:44:51 INFO - TEST-INFO | 11662: exit 0 19:44:51 INFO - TEST-OK | dromaeo_css | took 1117976ms 19:44:51 INFO - TEST-START | kraken 19:44:51 INFO - operating with platform_type : linux_ 19:44:51 INFO - Initialising browser for kraken test... 19:44:51 INFO - TEST-INFO | started process 11840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44FGcV/profile http://localhost:44182/getInfo.html) 19:44:55 INFO - PROCESS | 11840 | __metrics Screen width/height:1600/1200 19:44:55 INFO - PROCESS | 11840 | colorDepth:24 19:44:55 INFO - PROCESS | 11840 | Browser inner width/height: 1024/697 19:44:55 INFO - PROCESS | 11840 | __metrics 19:44:56 ERROR - PROCESS | 11840 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:44:57 INFO - TEST-INFO | 11840: exit 0 19:44:57 INFO - Browser initialized. 19:44:57 INFO - Running cycle 1/1 for kraken test... 19:44:57 INFO - TEST-INFO | started process 11923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44FGcV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:09 INFO - PROCESS | 11923 | RSS: Main: 153931776 19:45:09 INFO - PROCESS | 11923 | 19:45:12 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-beat-detection) 19:45:13 INFO - PROCESS | 11923 | RSS: Main: 209809408 19:45:13 INFO - PROCESS | 11923 | 19:45:15 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-dft) 19:45:16 INFO - PROCESS | 11923 | RSS: Main: 197701632 19:45:16 INFO - PROCESS | 11923 | 19:45:19 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-fft) 19:45:20 INFO - PROCESS | 11923 | RSS: Main: 265515008 19:45:20 INFO - PROCESS | 11923 | 19:45:22 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-oscillator) 19:45:23 INFO - PROCESS | 11923 | RSS: Main: 175132672 19:45:23 INFO - PROCESS | 11923 | 19:45:25 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:45:26 INFO - PROCESS | 11923 | RSS: Main: 178941952 19:45:26 INFO - PROCESS | 11923 | 19:45:29 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44182/tests/kraken/driver.html?testName=imaging-darkroom) 19:45:30 INFO - PROCESS | 11923 | RSS: Main: 215375872 19:45:30 INFO - PROCESS | 11923 | 19:45:33 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44182/tests/kraken/driver.html?testName=imaging-desaturate) 19:45:34 INFO - PROCESS | 11923 | RSS: Main: 213786624 19:45:34 INFO - PROCESS | 11923 | 19:45:37 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44182/tests/kraken/driver.html?testName=json-parse-financial) 19:45:38 INFO - PROCESS | 11923 | RSS: Main: 214794240 19:45:38 INFO - PROCESS | 11923 | 19:45:39 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:45:40 INFO - PROCESS | 11923 | RSS: Main: 208965632 19:45:40 INFO - PROCESS | 11923 | 19:45:42 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:45:43 INFO - PROCESS | 11923 | RSS: Main: 209416192 19:45:43 INFO - PROCESS | 11923 | 19:45:45 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:45:46 INFO - PROCESS | 11923 | RSS: Main: 212905984 19:45:46 INFO - PROCESS | 11923 | 19:45:48 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:45:49 INFO - PROCESS | 11923 | RSS: Main: 217886720 19:45:49 INFO - PROCESS | 11923 | 19:45:52 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:45:53 INFO - PROCESS | 11923 | RSS: Main: 215941120 19:45:53 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44182/tests/kraken/driver.html?testName=ai-astar) 19:45:55 INFO - PROCESS | 11923 | RSS: Main: 262664192 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | __start_tp_report 19:45:55 INFO - PROCESS | 11923 | _x_x_mozilla_page_load 19:45:55 INFO - PROCESS | 11923 | _x_x_mozilla_page_load_details 19:45:55 INFO - PROCESS | 11923 | |i|pagename|runs| 19:45:55 INFO - PROCESS | 11923 | |0;ai-astar;114;108;113;114;114;114;113;114;113;115 19:45:55 INFO - PROCESS | 11923 | |1;audio-beat-detection;160;134;152;220;142;158;152;131;194;130 19:45:55 INFO - PROCESS | 11923 | |2;audio-dft;159;161;159;161;160;161;162;162;161;162 19:45:55 INFO - PROCESS | 11923 | |3;audio-fft;75;76;76;143;76;75;77;75;142;76 19:45:55 INFO - PROCESS | 11923 | |4;audio-oscillator;92;93;154;93;93;93;130;92;92;127 19:45:55 INFO - PROCESS | 11923 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 19:45:55 INFO - PROCESS | 11923 | |6;imaging-darkroom;146;148;145;147;145;147;145;147;145;146 19:45:55 INFO - PROCESS | 11923 | |7;imaging-desaturate;94;95;95;95;94;95;94;95;95;94 19:45:55 INFO - PROCESS | 11923 | |8;json-parse-financial;68;68;68;68;68;66;67;67;69;74 19:45:55 INFO - PROCESS | 11923 | |9;json-stringify-tinderbox;63;64;63;65;64;63;63;67;64;64 19:45:55 INFO - PROCESS | 11923 | |10;stanford-crypto-aes;82;82;81;82;82;83;84;89;141;90 19:45:55 INFO - PROCESS | 11923 | |11;stanford-crypto-ccm;138;130;132;129;138;128;129;136;147;135 19:45:55 INFO - PROCESS | 11923 | |12;stanford-crypto-pbkdf2;175;176;177;175;174;178;176;175;173;170 19:45:55 INFO - PROCESS | 11923 | |13;stanford-crypto-sha256-iterative;68;70;71;68;68;67;67;68;67;66 19:45:55 INFO - PROCESS | 11923 | __end_tp_report 19:45:55 INFO - PROCESS | 11923 | __start_cc_report 19:45:55 INFO - PROCESS | 11923 | _x_x_mozilla_cycle_collect,2041 19:45:55 INFO - PROCESS | 11923 | __end_cc_report 19:45:55 INFO - PROCESS | 11923 | __startTimestamp1462934755290__endTimestamp 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | ------- Summary: start ------- 19:45:55 INFO - PROCESS | 11923 | Number of tests: 14 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.93 (1.7%) stddev-sans-first:2.03 19:45:55 INFO - PROCESS | 11923 | Values: 114.0 108.0 113.0 114.0 114.0 114.0 113.0 114.0 113.0 115.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:155.00 stddev:28.98 (18.7%) stddev-sans-first:30.72 19:45:55 INFO - PROCESS | 11923 | Values: 160.0 134.0 152.0 220.0 142.0 158.0 152.0 131.0 194.0 130.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.00 19:45:55 INFO - PROCESS | 11923 | Values: 159.0 161.0 159.0 161.0 160.0 161.0 162.0 162.0 161.0 162.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#3] audio-fft Cycles:10 Average:89.10 Median:76.00 stddev:28.15 (37.0%) stddev-sans-first:29.39 19:45:55 INFO - PROCESS | 11923 | Values: 75.0 76.0 76.0 143.0 76.0 75.0 77.0 75.0 142.0 76.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:92.50 stddev:22.57 (24.4%) stddev-sans-first:23.37 19:45:55 INFO - PROCESS | 11923 | Values: 92.0 93.0 154.0 93.0 93.0 93.0 130.0 92.0 92.0 127.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:45:55 INFO - PROCESS | 11923 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:1.10 (0.8%) stddev-sans-first:1.17 19:45:55 INFO - PROCESS | 11923 | Values: 146.0 148.0 145.0 147.0 145.0 147.0 145.0 147.0 145.0 146.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:45:55 INFO - PROCESS | 11923 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:68.00 stddev:2.16 (3.2%) stddev-sans-first:2.29 19:45:55 INFO - PROCESS | 11923 | Values: 68.0 68.0 68.0 68.0 68.0 66.0 67.0 67.0 69.0 74.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:1.25 (1.9%) stddev-sans-first:1.27 19:45:55 INFO - PROCESS | 11923 | Values: 63.0 64.0 63.0 65.0 64.0 63.0 63.0 67.0 64.0 64.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:82.50 stddev:18.33 (22.2%) stddev-sans-first:19.23 19:45:55 INFO - PROCESS | 11923 | Values: 82.0 82.0 81.0 82.0 82.0 83.0 84.0 89.0 141.0 90.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:135.50 stddev:5.88 (4.3%) stddev-sans-first:6.08 19:45:55 INFO - PROCESS | 11923 | Values: 138.0 130.0 132.0 129.0 138.0 128.0 129.0 136.0 147.0 135.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.50 stddev:2.23 (1.3%) stddev-sans-first:2.37 19:45:55 INFO - PROCESS | 11923 | Values: 175.0 176.0 177.0 175.0 174.0 178.0 176.0 175.0 173.0 170.0 19:45:55 INFO - PROCESS | 11923 | 19:45:55 INFO - PROCESS | 11923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 19:45:55 INFO - PROCESS | 11923 | Values: 68.0 70.0 71.0 68.0 68.0 67.0 67.0 68.0 67.0 66.0 19:45:55 INFO - PROCESS | 11923 | -------- Summary: end -------- 19:45:55 INFO - PROCESS | 11923 | 19:45:56 INFO - TEST-INFO | 11923: exit 0 19:45:56 INFO - TEST-OK | kraken | took 64746ms 19:45:56 INFO - SUITE-END | took 1182s 19:45:56 INFO - Completed test suite (00:19:43) 19:45:56 INFO - javascript benchmark 19:45:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.2714503511543, 2654.920352389428, 2686.4627074585087, 2707.8239914405563, 2722.1697382298403, 4662.533746625344, 4667.4399072111355, 4725.551072648102, 4794.376731024966, 4796.784144713483, 4623.514530974249, 4653.046125544255, 4656.534346565341, 4680.5787479126875, 4711.882202944928, 4246.787660616972, 4289.378040184171, 4318.719283246594, 4350.630196433307, 4564.9087018259615, 4474.709143905636, 4491.663125265618, 4502.122086193193, 4532.048269863316, 4553.704009239405, 4264.87205383839, 4285.3786201000685, 4311.698181127323, 4339.891502712426, 4360.498542667587, 4359.455068116486, 4370.584794444522, 4371.737695738234, 4377.146456440995, 4467.664925130595, 4385.539518350559, 4399.912001759979, 4411.933820992687, 4447.421835161441, 4459.665525085632, 4507.774611269423, 4648.233041548175, 4692.343071969927, 4728.905421891577, 4775.997040621473, 5123.923141152885, 5156.535911767922, 5170.715610641413, 5173.0, 5176.5858731301405, 5161.354830646169, 5162.457941916082, 5182.896342073137, 5201.219817027476, 5208.791648334062, 4684.039771846763, 4759.16714574948, 4798.3042458843975, 4799.0641824844515, 4858.246971719389, 5269.341332333458, 5278.392984806719, 5290.761915713802, 5292.9735351323, 5297.443768404262, 5052.621053421009, 5088.338515992898, 5097.260897169889, 5105.719185444762, 5106.974465127651, 5003.049420610072, 5118.360204974379, 5175.327207463081, 5175.637705360588, 5254.500822421864, 5147.433782283946, 5155.74221288934, 5156.664816786897, 5162.716050617177, 5178.093833579184, 5130.48695130484, 5139.434662187231, 5150.175971844487, 5158.8968220636125, 5201.713905735221, 4264.6801489888385, 4296.291111966553, 4323.027318853233, 4340.066885619607, 4394.209042372339, 3762.9059273518383, 3774.5281839770028, 3776.1692427666417, 3802.0114770159403, 3821.6560509554274, 4303.33298338758, 4307.698461107755, 4309.719868208556, 4346.500152482442, 4355.259605867011, 4961.0, 4963.429205641325, 4973.776180071905, 5046.470120637354, 5074.4671809460215, 4229.577042295808, 4237.406763053175, 4240.109576988867, 4252.510961239497, 4291.0130669945465, 4516.1419330327135, 4528.0943811237885, 4531.093781243764, 4571.885702857455, 4576.290674945389, 4676.883077923079, 4796.016816552528, 4842.854714358434, 4862.294967229661, 4877.9024419512125, 5148.176291793295, 5173.22401639757, 5193.7403129844115, 5195.636305458582, 5268.341457317835, 4669.9533004670875, 4693.741844198602, 4699.4830568636735, 4704.411948506437, 4712.646551508582, 4996.275540046746, 5002.874928126826, 5039.798408063636, 5087.64386492942, 5105.540501354896, 5120.795168193231, 5137.717425541481, 5138.948610513847, 5139.383274007143, 5160.148575485003, 4983.451820299837, 4984.327115839315, 4987.102321582005, 4987.301777751045, 5019.924701129413, 4878.243872199815, 4964.156093464047, 5013.0, 5016.924746128884, 5053.26727624485, 4950.356453661001, 4962.082014827124, 4965.30485732005, 4997.675151115166, 5001.549860512571, 4786.210275304536, 5062.392512898476, 5073.797048118034, 5098.694078355311, 5116.07910576085, 4677.298405239241, 4691.202495575692, 4704.764761761967, 4704.976475117603, 4708.199606066908], "value": 4679.136967739771, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.0372063770951, 598.7485256192399, 599.6581948289477, 601.6630686815382, 620.2618883528602, 27577.31056723583, 41817.0, 42609.57390426095, 42707.572924270746, 42773.14453710928, 41766.37350439746, 42378.364324535156, 42437.57562424375, 42441.15117697644, 42469.575304247024, 7900.170482099368, 8029.638666260033, 8036.557989310586, 8040.0, 8044.115147333789, 7716.035495563055, 7764.0, 7773.961130194341, 7819.0, 7822.374210063182, 7756.340711039568, 7819.687212511492, 7881.09367422748, 7893.171217022216, 7899.9210007899765, 7742.806429839299, 7755.340796032344, 7776.183500732426, 7800.570968596753, 7856.882146767803, 7813.2577405146985, 7853.685852565891, 7859.37125030002, 7865.9606701966695, 7875.76372708814, 39576.40635390471, 39848.40227396591, 39937.0, 39973.80013099945, 40003.7999810002, 3053.4351145038017, 3150.6691797361404, 3238.3199528099126, 3250.9187270318193, 3683.4843121962945, 28600.856995715098, 30716.2320941976, 30976.225594360098, 30986.225344366347, 31002.0699379019, 3051.6032915721034, 3136.8902088427026, 3169.4611915974338, 3188.6333071696818, 3326.5841769778776, 251437.0, 251590.0, 253718.0, 253726.73136634383, 253754.0, 58005.70997144987, 59150.0, 59445.405545943984, 59446.70276648589, 59514.0, 53662.195067074026, 61947.38052619506, 63841.0, 63876.68061659755, 69093.65453172702, 14179.291035448186, 14214.857851421353, 14244.786328205086, 14275.857241427453, 14347.56957291283, 10822.78354432907, 10951.34291942486, 10993.505292261867, 11011.669649910515, 11042.889571104346, 19053.523661908286, 19530.915144084687, 20125.698114528295, 20349.694754578693, 20473.590528189354, 7241.2396698346965, 7262.927370726331, 7356.558606483628, 7412.85174296511, 7586.810329741801, 862.2843040276556, 899.4738078224312, 941.4163218804248, 959.3524371049654, 1030.7680771826429, 27965.72034279631, 28959.276018099295, 29087.56368654472, 29271.560926586117, 29290.85354573256, 1000.849872519128, 1036.5180191211123, 1131.2759833706434, 1137.6643890052455, 1140.2702270546856, 15321.616959575877, 15396.384144634314, 15589.454369097028, 15751.606209844846, 15806.288717007763, 338787.0, 340932.0, 342876.0, 343512.0, 344308.0, 33226.50160247598, 33538.66461335404, 33722.15694607605, 33759.15602109967, 33762.662373375955, 1165.8950694437542, 1290.4064130499887, 1308.685915380321, 1321.1478596305328, 1324.675454513631, 29256.7074329254, 29269.41461170807, 30323.574114071263, 30511.54232686467, 30731.846340768152, 44772.418206542745, 49801.0, 50406.0, 50414.49585504245, 50480.49519504905, 331527.0, 332184.0, 332241.0, 333445.0, 335316.0, 34609.0, 35777.46333805047, 43153.0, 44178.779106104266, 44688.77655611701, 43511.78244108759, 44256.778716106215, 45604.771976139906, 45822.31266530938, 46007.53992460033, 36277.637223627426, 37900.2419951605, 37936.62063379331, 37985.43021854619, 38000.0, 36687.26625467529, 37215.25569488541, 37869.0, 37889.0, 38176.0, 36008.0, 36178.0, 36641.633583663825, 37017.0, 37122.14389280579, 31412.52881206738, 33193.336133277684, 33625.66374336225, 35173.47239791354, 35194.64805352016, 25626.359341016625, 25977.610335844598, 26276.42630313736, 26354.472910542067, 26550.0], "value": 18187.173472338487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.5040421037913, 382.5390404562502, 390.9863154789582, 392.0121294338266, 404.7571457125723, 16787.41244056458, 17123.74314385285, 17779.111044447774, 17854.55363615907, 17855.19651615677, 16892.662146757088, 17369.305227790872, 17398.304067837304, 17642.117894105308, 17678.0, 4929.235968424891, 5047.596192304625, 5086.211637196222, 5115.360579927509, 5131.666441681279, 3664.9450258246147, 3875.2249550090096, 5656.886862262752, 5960.612560183574, 5974.731137098841, 5989.431004054608, 6016.127661489081, 6016.578839481238, 6021.879562408749, 6022.608530445529, 5705.800296989606, 5811.418858114154, 5822.592418530705, 5998.790042348519, 6051.727672254737, 3391.8643254270046, 4980.526849949249, 5298.788048478056, 5307.575393968474, 5392.622516423852, 19868.80131198684, 20187.697184542245, 20194.091265892923, 20570.280040198522, 21014.684779728315, 1931.8164774346415, 1965.6068786242665, 2013.8993050347572, 2039.3983774786473, 2104.431803413085, 13011.0, 13108.47566097355, 13121.47514099435, 13138.146020508731, 13368.39842207103, 1789.7046987247088, 1809.1135343681633, 1826.0869565217392, 1831.8534517238722, 1878.9436316910515, 66756.0, 67863.0, 68203.0, 68726.65636671835, 68758.65620671865, 9391.389559678599, 9422.481763502936, 9706.0, 9815.312928095107, 9850.162736167362, 13684.52104176369, 13813.585592432242, 13827.239501827496, 13830.441368346888, 13865.722685546232, 7157.997880296763, 7186.784396468114, 7249.8550028999125, 7378.704851805975, 7391.889121663179, 6974.0, 6986.196587392414, 7037.190723066913, 7131.393831524275, 7232.204457509775, 6134.877302453926, 6149.292831324366, 6216.906746398808, 6221.720022598994, 6242.563020588606, 1621.6675581505763, 1738.6696527659703, 1827.2682339901933, 1830.381958230759, 1854.7125195594704, 916.0701887584107, 982.7346616413529, 983.4148681534618, 1007.0433088565745, 1035.7048241251207, 16012.839871601134, 16885.831141688424, 17051.403200887908, 17121.315147393965, 17378.39175628847, 954.9809003820023, 955.1928620315822, 955.5652178258875, 959.8176346494143, 968.5931908598405, 9823.263255255884, 9976.201903847676, 10081.798364032826, 10102.69691909244, 10112.292139550162, 413313.0, 422399.0, 422867.0, 440381.0, 446537.0, 83833.58083209668, 84835.57582212049, 87107.0, 88362.11637883539, 89112.5544372274, 946.2666433514082, 967.8161149381594, 968.5738275158908, 985.6944347252374, 992.5235886774389, 15278.159701216095, 15594.298256578708, 15782.131982741059, 15808.683826323639, 15982.200889955688, 36475.817620912785, 36946.63053369432, 36965.630343697296, 37863.43204851874, 38330.0, 50445.49554504408, 50883.2367514495, 51955.0, 52066.21900671417, 52648.0, 7587.886181707389, 7724.266194711493, 7737.845243095219, 7781.103035485331, 7997.680092796223, 8692.782680432787, 10900.672979810619, 11733.296002239893, 12014.75970480568, 12129.69675758113, 9846.519833475895, 10046.196304295492, 10096.444695541815, 10230.130438912776, 10547.388550257181, 10164.644237451654, 10420.635277765241, 10424.478776061014, 10428.426436546062, 10503.632372866912, 9755.658551950648, 9845.360051596623, 10168.74578135523, 10325.070743633109, 10360.171186305228, 7653.57905315213, 7799.49303295284, 7857.960710196412, 7893.605319734105, 7948.761537153895, 9662.806743865223, 9663.661771837951, 9732.464714440774, 10109.545070471699, 10377.792444150924], "value": 8529.279106450726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.574388323795, 1467.310364128859, 1532.9463468778592, 1725.2064050536753, 1886.3020682347526, 6591.274959754423, 7626.428017898659, 7884.566348850811, 7888.368930485562, 8092.10986791454, 7845.176256493071, 8020.759377218678, 8021.237982391678, 8028.3978701597325, 8031.799205019877, 2220.822334213267, 2248.1457046322375, 2252.88735563222, 2254.1434254983083, 2255.458689914417, 2203.867767933921, 2206.3822129803602, 2271.7728227177317, 2273.829462790289, 2274.7611500792427, 2201.9449513762124, 2214.745304290003, 2230.520438105815, 2231.0183519251477, 2242.9775702242932, 2120.4274845791706, 2145.3349461666853, 2154.1706443019393, 2154.741431028271, 2158.4388059104667, 2130.9558316424996, 2138.379869837745, 2142.4429648291402, 2143.057054895841, 2145.978540214609, 7684.538927664358, 7905.762827115196, 7918.049834019955, 8049.879251811228, 8050.718224862102, 4906.852794416173, 4966.354373931402, 5010.398752149729, 5018.723970181639, 5025.623078269108, 2878.1506308754183, 2946.175070980129, 2949.5133303004977, 2975.375171214026, 3015.72858442739, 873.9606717697719, 887.8623813308948, 888.1118881118881, 889.3241136736127, 906.8549032154824, 10678.679639610824, 10783.730406739816, 10799.946000270027, 10818.08046316064, 10838.891611083867, 4163.375493675912, 4273.850415235452, 4326.58897404746, 4363.061941682554, 4366.19225443294, 8704.390692651454, 8706.695265665798, 8711.869321960176, 8731.170538798804, 8741.562921853882, 4718.05638872227, 4724.126036683225, 4725.881852953704, 4735.810567577259, 4736.360591320196, 3823.101571130838, 4178.811953462102, 4293.677974151951, 4340.739555626673, 4509.594136527663, 3419.555457790521, 3427.845746941394, 3520.735944804099, 3522.2075033117344, 3522.682958533693, 1007.0734923870057, 1020.5917632946732, 1024.5440778853488, 1025.3642741500319, 1035.7410647338165, 916.5371487398821, 919.8022425178618, 923.0677016213673, 949.6913503111516, 950.9857352139724, 5516.9448305516435, 5757.942420575824, 5814.796482123105, 5828.184054232411, 5936.495397891142, 890.4790697441939, 894.9552522373855, 933.6638810028385, 950.6862735297335, 961.8845738511424, 3767.246550689873, 3820.1977584707524, 3874.767513949172, 3931.0761970936805, 3975.860844870416, 9175.862362064574, 9927.702168934944, 9972.501374931224, 9990.40057596532, 10001.399916005063, 9566.760830979141, 9663.46850923206, 9908.256880733974, 9923.503824808731, 9936.50317484123, 7400.481966262418, 7634.274743899321, 7687.923690683308, 7703.6918523259565, 7755.0, 5409.107497262908, 5444.972775136099, 5505.504504594605, 5590.105583106683, 5622.9718851407115, 8590.398672093144, 8787.34094942869, 9323.766905827137, 9359.766005849908, 9404.294677899321, 9151.17639412456, 9192.17270445663, 9329.766755831159, 9369.953150234205, 9449.102335278138, 6235.657038862906, 6834.1457317835275, 6906.965465172642, 6995.8251043722275, 7054.823629409306, 7581.3176814087, 7607.239276072349, 7676.846463070596, 7678.424118191047, 7697.6151192441275, 6980.441564674916, 7126.928730712834, 7133.964330178316, 7236.276372362932, 7252.673629686782, 6880.0, 6928.792136235921, 7031.929680703128, 7054.4003759681, 7073.575585464889, 6234.127222188988, 6523.412892839668, 6538.607683539003, 6608.768693095719, 6694.564853284521, 4775.904481910412, 4849.975750121227, 4857.392825896763, 4862.3922009748785, 4902.362692849907, 4972.2790195422185, 4985.875353116056, 5019.551868206975, 5047.545720885138, 5075.441701412916], "value": 4246.377649472211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.6590881847605, 317.72675499070795, 321.42625413636665, 325.5702472735988, 325.6661921530431, 4781.18719817631, 4791.257355109963, 4793.808247670094, 4796.232602783555, 4817.518248175181, 4707.599854012413, 4719.504452032538, 4735.479097299294, 4741.336212930192, 4749.311349854269, 3580.409232476645, 3602.7478076534653, 3702.426123950792, 3714.7956862372557, 3777.0368556018175, 3744.9625503744887, 3760.680342170905, 3775.1505911170043, 3779.9622003780023, 3807.257584770971, 3564.2515071834946, 3766.886993390203, 3772.5850156482766, 3772.8868133956025, 3799.3161230978412, 3600.1539638185004, 3703.777773333609, 3727.1178055082282, 3727.925441491182, 3738.981305093457, 3278.4590542560686, 3296.9175770605925, 3297.76915615907, 3299.5050742388594, 3312.1554003728893, 4505.932411013838, 4514.841980530666, 4527.7283362998, 4528.094381123756, 4534.344964088117, 3976.8210430530694, 4222.577742225783, 4249.723767955073, 4259.488861336628, 4279.700420970534, 4911.140550403665, 4920.876978075541, 4940.6788558743565, 4952.232403977389, 4952.851414457572, 3517.208628058692, 3554.2713743682743, 3580.6419358064245, 3590.335787879251, 3600.819959002066, 5022.824201152942, 5165.74171291434, 5188.481151884819, 5199.48005199477, 5203.089459344599, 3637.654422829827, 3643.599204087548, 3653.8173091345857, 3657.2868290683064, 3659.5425571803526, 3694.907627309285, 3697.8890633281044, 3699.8335074921692, 3701.9074523137137, 3706.2772759312215, 4194.916101678011, 4199.790010499462, 4206.642435392964, 4220.134872351161, 4225.830966761357, 4865.197242455026, 4936.950630493721, 4948.490710333383, 4969.229769385751, 4977.626677999092, 1269.7333559952513, 1275.2603489975793, 1277.8530468995998, 1290.6386211860695, 1291.599604122706, 813.983720325602, 830.3606223208217, 852.6205838401852, 868.847951608466, 868.8522951098329, 4265.274903266452, 4290.957090429056, 4309.202797482476, 4317.438732964694, 4325.653947684178, 4980.850574482772, 4986.80052797884, 4995.450500444948, 5066.392032956069, 5077.314562534085, 4149.937750933738, 4267.0825772459075, 4268.722533035343, 4292.248856450109, 4320.524742278347, 2692.6095716121054, 2706.648135742341, 2712.6744790625253, 2715.823471474348, 2719.2386131883104, 4706.152892479318, 4727.125481785881, 4748.810047598126, 4806.9570432566015, 4844.685095468783, 4972.975135124301, 4990.674641456054, 5099.413567439792, 5195.6622819516615, 5200.869978250574, 4717.8112875485285, 4760.0, 4765.594924431392, 4768.284757286435, 4774.3315935769715, 5022.974885125551, 5032.295478633067, 5044.369453818273, 5068.873278167928, 5085.618578606545, 4730.290456431563, 4853.174960256835, 4899.485554016777, 4901.779419926183, 4927.975360123177, 4705.364775755229, 4710.4347478302825, 4719.433667959866, 4740.7910982699195, 4746.477887432448, 3619.0, 3634.545681789776, 3635.8000309983204, 3636.1091532574687, 3645.1433913030946, 4822.493638167942, 4885.900672348693, 5022.221555658879, 5033.899322013613, 5065.39215294167, 4819.903601928012, 4823.0, 4824.155772739687, 4832.44426890912, 4835.975820120877, 4819.204831202953, 4832.420109586872, 4844.660873738945, 4868.853934381974, 4873.905070280327, 4559.794809233659, 4726.621870250303, 4742.66801323904, 4770.117528257283, 4780.211265141213, 4914.533119353656, 4959.20652695567, 4990.3762029746285, 5009.148444764326, 5027.446980832033, 4852.927206091982, 4856.732879691651, 4866.829660961849, 4900.705957642553, 4932.0], "value": 3732.9180280525447, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.8121307247044, 728.2499026003219, 728.9198188199297, 760.9726868727219, 785.3285440947985, 11786.587469438571, 12142.089343299265, 12188.0, 12228.694282642939, 12231.938840305796, 11036.11711063115, 11343.829842552368, 11523.48144333505, 11523.654290371282, 11558.653240402802, 693.9687714052855, 833.9332853371747, 859.6604341285189, 865.2299453486387, 883.4919921045392, 860.7761981884723, 861.2636196052379, 863.8056437301619, 863.952482613456, 864.4597126795753, 907.3829795738895, 907.9409838360485, 909.3316412436853, 909.4997751236826, 909.5361365703505, 718.7484380466847, 887.671561522241, 897.2597606974273, 897.7531178925848, 906.9093090690944, 641.7529251238307, 641.9133416988693, 642.0, 642.0689999500743, 647.6761619190405, 11635.650930472098, 11677.766444671059, 11680.415979201007, 11685.298882067103, 11692.707682307926, 10996.945015274872, 11434.656960291122, 11485.483153258123, 11537.192396532246, 11736.765264694744, 10407.167426605929, 10758.946205269001, 10874.18443616724, 11056.281341712844, 11373.147013973985, 4032.717709760318, 4059.9594004059877, 4090.7341022833716, 4144.937825932613, 4153.646940010103, 42258.57741422577, 42355.7882210587, 45241.77379113116, 45255.0, 45291.320630190574, 9491.38306010107, 9729.0, 9948.651797187063, 10366.688999330032, 10373.740656483647, 17884.195211215527, 17989.280428782702, 18000.0, 18047.278108875762, 18070.548236293936, 5584.357798853102, 5649.096144616841, 5659.3208814941645, 5776.555861034742, 5787.797427090031, 3565.4830049643174, 3617.764845285048, 3638.9818050910108, 3695.6858667013066, 3755.3052685253315, 2618.423946731716, 2692.0577797771016, 2692.151972128773, 2693.8922443102056, 2699.1227850948126, 467.18243074619414, 494.85896519491774, 507.9568236699922, 514.7426286856572, 515.8426679862678, 551.2640624765902, 576.4034224577542, 651.9282878883319, 654.1104098426136, 677.2144312597363, 8257.174282571816, 8290.295324897452, 8358.958205208935, 8451.492910425393, 8511.148885111439, 538.8221886777354, 562.4656576252495, 573.0430181596744, 583.6060659055206, 587.2952457051555, 3837.597052309523, 3896.8246428910766, 3941.7043721720984, 4021.2158629067053, 4118.588141185857, 48478.27282590764, 49026.75486622544, 49900.50099498958, 50246.748766255936, 50405.0, 44757.0, 45640.771796140805, 45875.77062114668, 45928.3110753339, 46170.76914615405, 40555.59444405518, 41448.79275603663, 41721.79139104285, 42046.57953420427, 42680.0, 7803.843923121619, 7841.294283514511, 7962.641681124479, 7964.20357964199, 8114.175113736312, 28374.0, 29066.854665726536, 29170.562441562968, 29299.560506592843, 29674.851625741732, 33819.32361352808, 35197.82401087978, 36682.26635467329, 36737.22416085892, 36989.44515832211, 10007.449590272605, 10067.446290454096, 10154.339967902062, 10385.169186465217, 10654.254202205771, 10687.946560267148, 10697.197710171613, 11125.221234513507, 11231.606893758679, 11619.88380116222, 10314.381137131797, 10506.212034097625, 10595.523201455799, 11037.392943388191, 11155.776884462428, 10009.949950250202, 10227.232957528066, 10305.124064454305, 10408.531616077144, 10720.67837964831, 10355.637552685619, 10373.481325933522, 10825.837612435662, 10844.457777110954, 10878.945605271923, 8383.245507904317, 8497.532635705096, 8663.870041949502, 8861.822763544564, 8899.599518021576, 9099.590518426554, 9224.529155337741, 9239.168474837297, 9309.255259579082, 9371.953140234255], "value": 5874.5670831126745, "unit": "score"}], "name": "dromaeo_css", "value": 6382.483248294748, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 115.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 134.0, 152.0, 220.0, 142.0, 158.0, 152.0, 131.0, 194.0, 130.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 143.0, 76.0, 75.0, 77.0, 75.0, 142.0, 76.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 93.0, 93.0, 93.0, 130.0, 92.0, 92.0, 127.0], "value": 105.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 145.0, 147.0, 145.0, 147.0, 145.0, 147.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 66.0, 67.0, 67.0, 69.0, 74.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 65.0, 64.0, 63.0, 63.0, 67.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 82.0, 82.0, 83.0, 84.0, 89.0, 141.0, 90.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 132.0, 129.0, 138.0, 128.0, 129.0, 136.0, 147.0, 135.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 177.0, 175.0, 174.0, 178.0, 176.0, 175.0, 173.0, 170.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1582.8, "alertThreshold": 2.0}]} 19:45:57 INFO - Return code: 0 19:45:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:45:57 ERROR - # TBPL SUCCESS # 19:45:57 INFO - Running post-action listener: _resource_record_post_action 19:45:57 INFO - ##### 19:45:57 INFO - ##### Finished run-tests step (success) 19:45:57 INFO - ##### 19:45:57 INFO - Running post-run listener: _resource_record_post_run 19:45:58 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531329024; Read time: 20; Write time: 390692 19:45:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234749952; Read time: 0; Write time: 211040 19:45:58 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296579072; Read time: 20; Write time: 179652 19:45:58 INFO - Running post-run listener: _upload_blobber_files 19:45:58 INFO - Blob upload gear active. 19:45:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:45:58 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 19:45:58 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'] 19:45:58 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 19:45:58 INFO - (blobuploader) - INFO - Open directory for files ... 19:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:59 INFO - (blobuploader) - INFO - Done attempting. 19:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:46:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:00 INFO - (blobuploader) - INFO - Done attempting. 19:46:00 INFO - (blobuploader) - INFO - Iteration through files over. 19:46:00 INFO - Return code: 0 19:46:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:46:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:46:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0249e0a4c6d70e5a2ddcc2e9a125df6016c77f0e2bd646dcac4370236c1798cf7671c4e541844f822d939a3f82fa8c6fce245dadef1bcae3b372faa3dfc9e2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1921942ce43aeb8fdddd71412849ddde485049b5fa87db5f8849fc45490c32d7d4b0ab8b4e6f65adefd6f2f08f3692e6d28842ab551d7a4258fefe1e8223d318"} 19:46:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:46:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:46:00 INFO - Contents: 19:46:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0249e0a4c6d70e5a2ddcc2e9a125df6016c77f0e2bd646dcac4370236c1798cf7671c4e541844f822d939a3f82fa8c6fce245dadef1bcae3b372faa3dfc9e2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1921942ce43aeb8fdddd71412849ddde485049b5fa87db5f8849fc45490c32d7d4b0ab8b4e6f65adefd6f2f08f3692e6d28842ab551d7a4258fefe1e8223d318"} 19:46:00 INFO - Running post-run listener: copy_logs_to_upload_dir 19:46:00 INFO - Copying logs to upload dir... 19:46:00 INFO - mkdir: /builds/slave/test/build/upload/logs 19:46:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.676394 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-10 19:46:00.253871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 19:46:00.257017) ========= 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=0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0249e0a4c6d70e5a2ddcc2e9a125df6016c77f0e2bd646dcac4370236c1798cf7671c4e541844f822d939a3f82fa8c6fce245dadef1bcae3b372faa3dfc9e2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1921942ce43aeb8fdddd71412849ddde485049b5fa87db5f8849fc45490c32d7d4b0ab8b4e6f65adefd6f2f08f3692e6d28842ab551d7a4258fefe1e8223d318"} build_url:https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/K4gQa8lXRMSgDnFvh-yq4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0249e0a4c6d70e5a2ddcc2e9a125df6016c77f0e2bd646dcac4370236c1798cf7671c4e541844f822d939a3f82fa8c6fce245dadef1bcae3b372faa3dfc9e2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1921942ce43aeb8fdddd71412849ddde485049b5fa87db5f8849fc45490c32d7d4b0ab8b4e6f65adefd6f2f08f3692e6d28842ab551d7a4258fefe1e8223d318"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 19:46:00.282062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:46:00.282392) ========= 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=0333a256a5e4f052382dd180000001b1-1462932829.956793-435333001 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 19:46:00.367348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 19:46:00.367894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 19:46:00.368382) ========= ========= Total master_lag: 0.17 =========