builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1462557873.5 results: success (0) buildid: 20160506083128 builduid: efa720bb69d34f369d59e60c62d31fdc revision: 4566e5d0d25c0caf5f385c43fbab78cf4eb9a6cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.502209) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.502788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.503064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.541840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.542212) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 11:04:34-- 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% 96.3M=0s 2016-05-06 11:04:34 (96.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093180 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.649339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.649652) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021462 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.701325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:33.701684) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4566e5d0d25c0caf5f385c43fbab78cf4eb9a6cb --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 4566e5d0d25c0caf5f385c43fbab78cf4eb9a6cb --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=d6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 11:04:34,282 truncating revision to first 12 chars 2016-05-06 11:04:34,282 Setting DEBUG logging. 2016-05-06 11:04:34,282 attempt 1/10 2016-05-06 11:04:34,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4566e5d0d25c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 11:04:34,535 unpacking tar archive at: fx-team-4566e5d0d25c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:34.264963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:34.265277) ========= script_repo_revision: 4566e5d0d25c0caf5f385c43fbab78cf4eb9a6cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:34.265702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:34.265968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 11:04:34.275034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-06 11:04:34.275654) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:04:34 INFO - MultiFileLogger online at 20160506 11:04:34 in /builds/slave/test 11:04:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:04:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:04:34 INFO - {'append_to_log': False, 11:04:34 INFO - 'base_work_dir': '/builds/slave/test', 11:04:34 INFO - 'blob_upload_branch': 'Fx-Team', 11:04:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:04:34 INFO - 'branch': 'Fx-Team', 11:04:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:04:34 INFO - 'config_files': ('talos/linux_config.py',), 11:04:34 INFO - 'default_actions': ('clobber', 11:04:34 INFO - 'read-buildbot-config', 11:04:34 INFO - 'download-and-extract', 11:04:34 INFO - 'populate-webroot', 11:04:34 INFO - 'create-virtualenv', 11:04:34 INFO - 'install', 11:04:34 INFO - 'run-tests'), 11:04:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:04:34 INFO - 'download_minidump_stackwalk': True, 11:04:34 INFO - 'download_symbols': 'ondemand', 11:04:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:04:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:04:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:04:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:04:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:04:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:04:34 INFO - 'installer_path': 'installer.exe', 11:04:34 INFO - 'log_level': 'info', 11:04:34 INFO - 'log_name': 'talos', 11:04:34 INFO - 'log_to_console': True, 11:04:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:04:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:04:34 INFO - 'opt_config_files': (), 11:04:34 INFO - 'pip_index': False, 11:04:34 INFO - 'sps_profile': False, 11:04:34 INFO - 'sps_profile_interval': 0, 11:04:34 INFO - 'suite': 'dromaeojs', 11:04:34 INFO - 'system_bits': '32', 11:04:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:04:34 INFO - 'title': 'talos-linux64-ix-034', 11:04:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:04:34 INFO - 'use_talos_json': True, 11:04:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:04:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:04:34 INFO - 'work_dir': 'build'} 11:04:34 INFO - ##### 11:04:34 INFO - ##### Running clobber step. 11:04:34 INFO - ##### 11:04:34 INFO - Running pre-action listener: _resource_record_pre_action 11:04:34 INFO - Running main action method: clobber 11:04:34 INFO - rmtree: /builds/slave/test/build 11:04:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:04:35 INFO - Running post-action listener: _resource_record_post_action 11:04:35 INFO - ##### 11:04:35 INFO - ##### Finished clobber step (success) 11:04:35 INFO - ##### 11:04:35 INFO - ##### 11:04:35 INFO - ##### Running read-buildbot-config step. 11:04:35 INFO - ##### 11:04:35 INFO - Running pre-action listener: _resource_record_pre_action 11:04:35 INFO - Running main action method: read_buildbot_config 11:04:35 INFO - Using buildbot properties: 11:04:35 INFO - { 11:04:35 INFO - "project": "", 11:04:35 INFO - "product": "firefox", 11:04:35 INFO - "script_repo_revision": "production", 11:04:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:04:35 INFO - "repository": "", 11:04:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:04:35 INFO - "buildid": "20160506083128", 11:04:35 INFO - "pgo_build": "True", 11:04:35 INFO - "basedir": "/builds/slave/test", 11:04:35 INFO - "buildnumber": 649, 11:04:35 INFO - "slavename": "talos-linux64-ix-034", 11:04:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:04:35 INFO - "platform": "ubuntu64_hw", 11:04:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:04:35 INFO - "branch": "fx-team", 11:04:35 INFO - "repo_path": "integration/fx-team", 11:04:35 INFO - "revision": "4566e5d0d25c0caf5f385c43fbab78cf4eb9a6cb", 11:04:35 INFO - "stage_platform": "linux64-pgo", 11:04:35 INFO - "builduid": "efa720bb69d34f369d59e60c62d31fdc", 11:04:35 INFO - "slavebuilddir": "test" 11:04:35 INFO - } 11:04:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:04:35 INFO - Running post-action listener: _resource_record_post_action 11:04:35 INFO - ##### 11:04:35 INFO - ##### Finished read-buildbot-config step (success) 11:04:35 INFO - ##### 11:04:35 INFO - ##### 11:04:35 INFO - ##### Running download-and-extract step. 11:04:35 INFO - ##### 11:04:35 INFO - Running pre-action listener: _resource_record_pre_action 11:04:35 INFO - Running main action method: download_and_extract 11:04:35 INFO - mkdir: /builds/slave/test/build/tests 11:04: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')]} 11:04:35 INFO - https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:39 INFO - Downloaded 1361 bytes. 11:04:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:04:39 INFO - Using the following test package requirements: 11:04:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:04:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:04:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'jsshell-linux-x86_64.zip'], 11:04:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:04:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:04:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:04:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:04:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:04:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:04:39 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')]} 11:04:39 INFO - https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:04:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:04:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:43 INFO - Downloaded 23894139 bytes. 11:04:43 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'] 11:04:43 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 11:04:44 INFO - Return code: 0 11:04:44 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 11:04:44 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')]} 11:04:44 INFO - https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:04:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:04:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:45 INFO - Downloaded 23894139 bytes. 11:04:45 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'] 11:04:45 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 11:04:46 INFO - Return code: 0 11:04: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')]} 11:04:46 INFO - https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:48 INFO - Downloaded 10840152 bytes. 11:04:48 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'] 11:04:48 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 11:04:48 INFO - Return code: 0 11:04:48 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')]} 11:04:48 INFO - https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:04:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:04:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:04:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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 11:04:50 INFO - Downloaded 58426488 bytes. 11:04:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:04:50 INFO - mkdir: /builds/slave/test/properties 11:04:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:04:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:04:50 INFO - Contents: 11:04:50 INFO - build_url:https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:04:51 INFO - Running post-action listener: _resource_record_post_action 11:04:51 INFO - Running post-action listener: set_extra_try_arguments 11:04:51 INFO - ##### 11:04:51 INFO - ##### Finished download-and-extract step (success) 11:04:51 INFO - ##### 11:04:51 INFO - ##### 11:04:51 INFO - ##### Running populate-webroot step. 11:04:51 INFO - ##### 11:04:51 INFO - Running pre-action listener: _resource_record_pre_action 11:04:51 INFO - Running main action method: populate_webroot 11:04:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:04:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:04:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:04:51 INFO - '--tppagecycles', 11:04:51 INFO - '7'], 11:04:51 INFO - 'tests': ['tsvgm']}}, 11:04:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:04:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:04:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:04:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:04:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['damp', 'tps']}, 11:04:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'tests': ['damp', 'tps']}, 11:04:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['dromaeo_dom']}, 11:04:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['a11yr', 11:04:51 INFO - 'ts_paint', 11:04:51 INFO - 'tpaint', 11:04:51 INFO - 'sessionrestore', 11:04:51 INFO - 'sessionrestore_no_auto_restore', 11:04:51 INFO - 'tabpaint']}, 11:04:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:04:51 INFO - 'ts_paint', 11:04:51 INFO - 'tpaint', 11:04:51 INFO - 'sessionrestore', 11:04:51 INFO - 'sessionrestore_no_auto_restore', 11:04:51 INFO - 'tabpaint']}, 11:04:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:04:51 INFO - 'ts_paint', 11:04:51 INFO - 'tpaint', 11:04:51 INFO - 'sessionrestore', 11:04:51 INFO - 'sessionrestore_no_auto_restore', 11:04:51 INFO - 'tabpaint']}, 11:04:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:04:51 INFO - 'ts_paint', 11:04:51 INFO - 'tpaint', 11:04:51 INFO - 'sessionrestore', 11:04:51 INFO - 'sessionrestore_no_auto_restore', 11:04:51 INFO - 'tabpaint']}, 11:04:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['a11yr', 11:04:51 INFO - 'ts_paint', 11:04:51 INFO - 'tpaint', 11:04:51 INFO - 'sessionrestore', 11:04:51 INFO - 'sessionrestore_no_auto_restore', 11:04:51 INFO - 'tabpaint']}, 11:04:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['a11yr', 11:04:51 INFO - 'ts_paint', 11:04:51 INFO - 'tpaint', 11:04:51 INFO - 'sessionrestore', 11:04:51 INFO - 'sessionrestore_no_auto_restore', 11:04:51 INFO - 'tabpaint']}, 11:04:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['tsvgx', 11:04:51 INFO - 'tsvgr_opacity', 11:04:51 INFO - 'tart', 11:04:51 INFO - 'tscrollx', 11:04:51 INFO - 'cart']}, 11:04:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:04:51 INFO - 'tsvgr_opacity', 11:04:51 INFO - 'tart', 11:04:51 INFO - 'tscrollx', 11:04:51 INFO - 'cart']}, 11:04:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'talos_options': ['--disable-e10s'], 11:04:51 INFO - 'tests': ['tp5o']}, 11:04:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'tests': ['tp5o']}, 11:04:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'talos_options': ['--disable-e10s', 11:04:51 INFO - '--xperf_path', 11:04:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:51 INFO - 'tests': ['tp5n']}, 11:04:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:51 INFO - 'talos_options': ['--xperf_path', 11:04:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:51 INFO - 'tests': ['tp5n']}}, 11:04:51 INFO - 'talos.zip': {'path': '', 11:04:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:04:51 INFO - Running post-action listener: _resource_record_post_action 11:04:51 INFO - ##### 11:04:51 INFO - ##### Finished populate-webroot step (success) 11:04:51 INFO - ##### 11:04:51 INFO - ##### 11:04:51 INFO - ##### Running create-virtualenv step. 11:04:51 INFO - ##### 11:04:51 INFO - Running pre-action listener: _resource_record_pre_action 11:04:51 INFO - Running main action method: create_virtualenv 11:04:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:04:51 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 11:04:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:04:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:51 INFO - Using real prefix '/usr' 11:04:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:04:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:53 INFO - Installing pip.................done. 11:04:53 INFO - Return code: 0 11:04:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:04: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', 'pip>=1.5'] in /builds/slave/test/build 11:04: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 pip>=1.5 11:04:53 INFO - Using env: {'DISPLAY': ':0', 11:04:53 INFO - 'HOME': '/home/cltbld', 11:04:53 INFO - 'LANG': 'en_US.UTF-8', 11:04:53 INFO - 'LANGUAGE': 'en_US:en', 11:04:53 INFO - 'LOGNAME': 'cltbld', 11:04:53 INFO - 'MAIL': '/var/mail/cltbld', 11:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:53 INFO - 'MOZ_NO_REMOTE': '1', 11:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:53 INFO - 'NO_EM_RESTART': '1', 11:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:53 INFO - 'PWD': '/builds/slave/test', 11:04:53 INFO - 'SHELL': '/bin/bash', 11:04:53 INFO - 'SHLVL': '1', 11:04:53 INFO - 'TERM': 'linux', 11:04:53 INFO - 'TMOUT': '86400', 11:04:53 INFO - 'USER': 'cltbld', 11:04:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:53 INFO - '_': '/tools/buildbot/bin/python'} 11:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:53 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 11:04:53 INFO - Cleaning up... 11:04:54 INFO - Return code: 0 11:04:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:54 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:04:54 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 11:04:54 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 11:04:54 INFO - Using env: {'DISPLAY': ':0', 11:04:54 INFO - 'HOME': '/home/cltbld', 11:04:54 INFO - 'LANG': 'en_US.UTF-8', 11:04:54 INFO - 'LANGUAGE': 'en_US:en', 11:04:54 INFO - 'LOGNAME': 'cltbld', 11:04:54 INFO - 'MAIL': '/var/mail/cltbld', 11:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:54 INFO - 'MOZ_NO_REMOTE': '1', 11:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:54 INFO - 'NO_EM_RESTART': '1', 11:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:54 INFO - 'PWD': '/builds/slave/test', 11:04:54 INFO - 'SHELL': '/bin/bash', 11:04:54 INFO - 'SHLVL': '1', 11:04:54 INFO - 'TERM': 'linux', 11:04:54 INFO - 'TMOUT': '86400', 11:04:54 INFO - 'USER': 'cltbld', 11:04:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:54 INFO - '_': '/tools/buildbot/bin/python'} 11:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:54 INFO - Downloading/unpacking psutil>=0.7.1 11:04:54 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 11:04:54 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 11:04:54 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 11:04:54 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 11:04:54 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 11:04:54 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 11:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:56 INFO - Installing collected packages: psutil 11:04:56 INFO - Running setup.py install for psutil 11:04:56 INFO - building 'psutil._psutil_linux' extension 11:04:56 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 11:04:56 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 11:04:56 INFO - building 'psutil._psutil_posix' extension 11:04:56 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 11:04:56 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 11:04:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:56 INFO - Successfully installed psutil 11:04:56 INFO - Cleaning up... 11:04:56 INFO - Return code: 0 11:04:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:04:56 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')]} 11:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:56 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')]} 11:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:56 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:04:56 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 11:04:56 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 11:04:56 INFO - Using env: {'DISPLAY': ':0', 11:04:56 INFO - 'HOME': '/home/cltbld', 11:04:56 INFO - 'LANG': 'en_US.UTF-8', 11:04:56 INFO - 'LANGUAGE': 'en_US:en', 11:04:56 INFO - 'LOGNAME': 'cltbld', 11:04:56 INFO - 'MAIL': '/var/mail/cltbld', 11:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:56 INFO - 'MOZ_NO_REMOTE': '1', 11:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:56 INFO - 'NO_EM_RESTART': '1', 11:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:56 INFO - 'PWD': '/builds/slave/test', 11:04:56 INFO - 'SHELL': '/bin/bash', 11:04:56 INFO - 'SHLVL': '1', 11:04:56 INFO - 'TERM': 'linux', 11:04:56 INFO - 'TMOUT': '86400', 11:04:56 INFO - 'USER': 'cltbld', 11:04:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:56 INFO - '_': '/tools/buildbot/bin/python'} 11:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:04:56 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 11:04:56 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 11:04:56 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 11:04:56 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 11:04:56 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 11:04:56 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 11:04:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:04:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:04:58 INFO - Installing collected packages: mozsystemmonitor 11:04:58 INFO - Running setup.py install for mozsystemmonitor 11:04:58 INFO - Successfully installed mozsystemmonitor 11:04:58 INFO - Cleaning up... 11:04:59 INFO - Return code: 0 11:04:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:04:59 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')]} 11:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:59 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')]} 11:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:59 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:04:59 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 11:04:59 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 11:04:59 INFO - Using env: {'DISPLAY': ':0', 11:04:59 INFO - 'HOME': '/home/cltbld', 11:04:59 INFO - 'LANG': 'en_US.UTF-8', 11:04:59 INFO - 'LANGUAGE': 'en_US:en', 11:04:59 INFO - 'LOGNAME': 'cltbld', 11:04:59 INFO - 'MAIL': '/var/mail/cltbld', 11:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:59 INFO - 'MOZ_NO_REMOTE': '1', 11:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:59 INFO - 'NO_EM_RESTART': '1', 11:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:59 INFO - 'PWD': '/builds/slave/test', 11:04:59 INFO - 'SHELL': '/bin/bash', 11:04:59 INFO - 'SHLVL': '1', 11:04:59 INFO - 'TERM': 'linux', 11:04:59 INFO - 'TMOUT': '86400', 11:04:59 INFO - 'USER': 'cltbld', 11:04:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:59 INFO - '_': '/tools/buildbot/bin/python'} 11:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:04:59 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 11:04:59 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 11:04:59 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 11:04:59 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 11:04:59 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 11:04:59 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 11:05:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 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 11:05:01 INFO - Downloading docopt-0.6.1.tar.gz 11:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:01 INFO - Running setup.py install for blobuploader 11:05:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:01 INFO - Running setup.py install for requests 11:05:02 INFO - Running setup.py install for docopt 11:05:02 INFO - Successfully installed blobuploader requests docopt 11:05:02 INFO - Cleaning up... 11:05:02 INFO - Return code: 0 11:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:02 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')]} 11:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:02 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')]} 11:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:02 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:05:02 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 11:05:02 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 11:05:02 INFO - Using env: {'DISPLAY': ':0', 11:05:02 INFO - 'HOME': '/home/cltbld', 11:05:02 INFO - 'LANG': 'en_US.UTF-8', 11:05:02 INFO - 'LANGUAGE': 'en_US:en', 11:05:02 INFO - 'LOGNAME': 'cltbld', 11:05:02 INFO - 'MAIL': '/var/mail/cltbld', 11:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:02 INFO - 'MOZ_NO_REMOTE': '1', 11:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:02 INFO - 'NO_EM_RESTART': '1', 11:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:02 INFO - 'PWD': '/builds/slave/test', 11:05:02 INFO - 'SHELL': '/bin/bash', 11:05:02 INFO - 'SHLVL': '1', 11:05:02 INFO - 'TERM': 'linux', 11:05:02 INFO - 'TMOUT': '86400', 11:05:02 INFO - 'USER': 'cltbld', 11:05:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:02 INFO - '_': '/tools/buildbot/bin/python'} 11:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:02 INFO - Running setup.py (path:/tmp/pip-ZVgOFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:02 INFO - Running setup.py (path:/tmp/pip-ctkCSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:02 INFO - Running setup.py (path:/tmp/pip-7AiWaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:02 INFO - Running setup.py (path:/tmp/pip-LBEjWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:02 INFO - Running setup.py (path:/tmp/pip-yRLmqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:03 INFO - Running setup.py (path:/tmp/pip-ozzWud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:03 INFO - Running setup.py (path:/tmp/pip-4vZXWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:03 INFO - Running setup.py (path:/tmp/pip-YBpKV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:03 INFO - Running setup.py (path:/tmp/pip-iB1zyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:03 INFO - Running setup.py (path:/tmp/pip-kEvlRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:03 INFO - Running setup.py (path:/tmp/pip-RGTR5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:03 INFO - Running setup.py (path:/tmp/pip-6lW_sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:03 INFO - Running setup.py (path:/tmp/pip-Bd91BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:03 INFO - Running setup.py (path:/tmp/pip-sdBO0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:03 INFO - Running setup.py (path:/tmp/pip-8wWyjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:03 INFO - Running setup.py (path:/tmp/pip-eCN7o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:03 INFO - Running setup.py (path:/tmp/pip-UMM65k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:03 INFO - Running setup.py install for manifestparser 11:05:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Running setup.py install for mozcrash 11:05:04 INFO - Running setup.py install for mozdebug 11:05:04 INFO - Running setup.py install for mozdevice 11:05:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Running setup.py install for mozfile 11:05:04 INFO - Running setup.py install for mozhttpd 11:05:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Running setup.py install for mozinfo 11:05:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Running setup.py install for mozInstall 11:05:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Running setup.py install for mozleak 11:05:04 INFO - Running setup.py install for mozlog 11:05:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:04 INFO - Running setup.py install for moznetwork 11:05:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:05 INFO - Running setup.py install for mozprocess 11:05:05 INFO - Running setup.py install for mozprofile 11:05:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:05 INFO - Running setup.py install for mozrunner 11:05:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:05 INFO - Running setup.py install for mozscreenshot 11:05:05 INFO - Running setup.py install for moztest 11:05:05 INFO - Running setup.py install for mozversion 11:05:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:05 INFO - Cleaning up... 11:05:05 INFO - Return code: 0 11:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:05:05 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 11:05:05 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 11:05:05 INFO - Using env: {'DISPLAY': ':0', 11:05:05 INFO - 'HOME': '/home/cltbld', 11:05:05 INFO - 'LANG': 'en_US.UTF-8', 11:05:05 INFO - 'LANGUAGE': 'en_US:en', 11:05:05 INFO - 'LOGNAME': 'cltbld', 11:05:05 INFO - 'MAIL': '/var/mail/cltbld', 11:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:05 INFO - 'MOZ_NO_REMOTE': '1', 11:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:05 INFO - 'NO_EM_RESTART': '1', 11:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:05 INFO - 'PWD': '/builds/slave/test', 11:05:05 INFO - 'SHELL': '/bin/bash', 11:05:05 INFO - 'SHLVL': '1', 11:05:05 INFO - 'TERM': 'linux', 11:05:05 INFO - 'TMOUT': '86400', 11:05:05 INFO - 'USER': 'cltbld', 11:05:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:05 INFO - '_': '/tools/buildbot/bin/python'} 11:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:05 INFO - Running setup.py (path:/tmp/pip-Bu8Ynx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:05 INFO - Running setup.py (path:/tmp/pip-dQAHYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:06 INFO - Running setup.py (path:/tmp/pip-VWPdJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:06 INFO - Running setup.py (path:/tmp/pip-8FwFtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:06 INFO - Running setup.py (path:/tmp/pip-VS4aNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:06 INFO - Running setup.py (path:/tmp/pip-nLyVSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:06 INFO - Running setup.py (path:/tmp/pip-yvSMCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:06 INFO - Running setup.py (path:/tmp/pip-SpWfqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:06 INFO - Running setup.py (path:/tmp/pip-2e8L71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:06 INFO - Running setup.py (path:/tmp/pip-Yt6Umj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:06 INFO - Running setup.py (path:/tmp/pip-WMuZAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:06 INFO - Running setup.py (path:/tmp/pip-RQkKQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:06 INFO - Running setup.py (path:/tmp/pip-4_lK9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:06 INFO - Running setup.py (path:/tmp/pip-2qnT1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:06 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)) 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:06 INFO - Running setup.py (path:/tmp/pip-c9Y1IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:07 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)) 11:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:07 INFO - Running setup.py (path:/tmp/pip-MJiYhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:07 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)) 11:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:07 INFO - Running setup.py (path:/tmp/pip-eVWCRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:07 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)) 11:05:07 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)) 11:05:07 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)) 11:05:07 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)) 11:05:07 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)) 11:05:07 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)) 11:05:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:07 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 11:05:07 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 11:05:07 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 11:05:07 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 11:05:07 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 11:05:07 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 11:05:09 INFO - Downloading blessings-1.6.tar.gz 11:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:09 INFO - Installing collected packages: blessings 11:05:09 INFO - Running setup.py install for blessings 11:05:09 INFO - Successfully installed blessings 11:05:09 INFO - Cleaning up... 11:05:09 INFO - Return code: 0 11:05:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:09 INFO - Reading from file tmpfile_stdout 11:05:09 INFO - Current package versions: 11:05:09 INFO - argparse == 1.2.1 11:05:09 INFO - blessings == 1.6 11:05:09 INFO - blobuploader == 1.2.4 11:05:09 INFO - docopt == 0.6.1 11:05:09 INFO - manifestparser == 1.1 11:05:09 INFO - mozInstall == 1.12 11:05:09 INFO - mozcrash == 0.17 11:05:09 INFO - mozdebug == 0.1 11:05:09 INFO - mozdevice == 0.48 11:05:09 INFO - mozfile == 1.2 11:05:09 INFO - mozhttpd == 0.7 11:05:09 INFO - mozinfo == 0.9 11:05:09 INFO - mozleak == 0.1 11:05:09 INFO - mozlog == 3.1 11:05:09 INFO - moznetwork == 0.27 11:05:09 INFO - mozprocess == 0.22 11:05:09 INFO - mozprofile == 0.28 11:05:09 INFO - mozrunner == 6.11 11:05:09 INFO - mozscreenshot == 0.1 11:05:09 INFO - mozsystemmonitor == 0.0 11:05:09 INFO - moztest == 0.7 11:05:09 INFO - mozversion == 1.4 11:05:09 INFO - psutil == 3.1.1 11:05:09 INFO - requests == 1.2.3 11:05:09 INFO - wsgiref == 0.1.2 11:05:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:09 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')]} 11:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:09 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')]} 11:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:09 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:05:09 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 11:05:09 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 11:05:09 INFO - Using env: {'DISPLAY': ':0', 11:05:09 INFO - 'HOME': '/home/cltbld', 11:05:09 INFO - 'LANG': 'en_US.UTF-8', 11:05:09 INFO - 'LANGUAGE': 'en_US:en', 11:05:09 INFO - 'LOGNAME': 'cltbld', 11:05:09 INFO - 'MAIL': '/var/mail/cltbld', 11:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:09 INFO - 'MOZ_NO_REMOTE': '1', 11:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:09 INFO - 'NO_EM_RESTART': '1', 11:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:09 INFO - 'PWD': '/builds/slave/test', 11:05:09 INFO - 'SHELL': '/bin/bash', 11:05:09 INFO - 'SHLVL': '1', 11:05:09 INFO - 'TERM': 'linux', 11:05:09 INFO - 'TMOUT': '86400', 11:05:09 INFO - 'USER': 'cltbld', 11:05:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:09 INFO - '_': '/tools/buildbot/bin/python'} 11:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 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)) 11:05:09 INFO - Cleaning up... 11:05:09 INFO - Return code: 0 11:05:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05:09 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')]} 11:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:09 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')]} 11:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:09 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:05:09 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 11:05:09 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 11:05:09 INFO - Using env: {'DISPLAY': ':0', 11:05:09 INFO - 'HOME': '/home/cltbld', 11:05:09 INFO - 'LANG': 'en_US.UTF-8', 11:05:09 INFO - 'LANGUAGE': 'en_US:en', 11:05:09 INFO - 'LOGNAME': 'cltbld', 11:05:09 INFO - 'MAIL': '/var/mail/cltbld', 11:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:09 INFO - 'MOZ_NO_REMOTE': '1', 11:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:09 INFO - 'NO_EM_RESTART': '1', 11:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:09 INFO - 'PWD': '/builds/slave/test', 11:05:09 INFO - 'SHELL': '/bin/bash', 11:05:09 INFO - 'SHLVL': '1', 11:05:09 INFO - 'TERM': 'linux', 11:05:09 INFO - 'TMOUT': '86400', 11:05:09 INFO - 'USER': 'cltbld', 11:05:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:09 INFO - '_': '/tools/buildbot/bin/python'} 11:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:09 INFO - Downloading/unpacking jsonschema 11:05:09 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 11:05:09 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 11:05:09 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 11:05:09 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 11:05:09 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 11:05:09 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 11:05:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:11 INFO - Downloading/unpacking functools32 (from jsonschema) 11:05:11 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 11:05:11 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 11:05:11 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 11:05:11 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 11:05:11 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 11:05:11 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 11:05:11 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:12 INFO - warning: no files found matching '*.txt' 11:05:12 INFO - no previously-included directories found matching 'build' 11:05:12 INFO - no previously-included directories found matching 'dist' 11:05:12 INFO - no previously-included directories found matching '.git*' 11:05:12 INFO - Installing collected packages: jsonschema, functools32 11:05:12 INFO - Running setup.py install for functools32 11:05:12 INFO - warning: no files found matching '*.txt' 11:05:12 INFO - no previously-included directories found matching 'build' 11:05:12 INFO - no previously-included directories found matching 'dist' 11:05:12 INFO - no previously-included directories found matching '.git*' 11:05:12 INFO - Successfully installed jsonschema functools32 11:05:12 INFO - Cleaning up... 11:05:12 INFO - Return code: 0 11:05:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 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 0x7f9504c40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', '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 11:05:12 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 11:05:12 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 11:05:12 INFO - Using env: {'DISPLAY': ':0', 11:05:12 INFO - 'HOME': '/home/cltbld', 11:05:12 INFO - 'LANG': 'en_US.UTF-8', 11:05:12 INFO - 'LANGUAGE': 'en_US:en', 11:05:12 INFO - 'LOGNAME': 'cltbld', 11:05:12 INFO - 'MAIL': '/var/mail/cltbld', 11:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:12 INFO - 'MOZ_NO_REMOTE': '1', 11:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:12 INFO - 'NO_EM_RESTART': '1', 11:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:12 INFO - 'PWD': '/builds/slave/test', 11:05:12 INFO - 'SHELL': '/bin/bash', 11:05:12 INFO - 'SHLVL': '1', 11:05:12 INFO - 'TERM': 'linux', 11:05:12 INFO - 'TMOUT': '86400', 11:05:12 INFO - 'USER': 'cltbld', 11:05:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:12 INFO - '_': '/tools/buildbot/bin/python'} 11:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:12 INFO - Downloading/unpacking flake8 11:05:12 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 11:05:12 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 11:05:12 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 11:05:12 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 11:05:12 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 11:05:12 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 11:05:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:05:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:05:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:05:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:15 INFO - no previously-included directories found matching 'docs/_build' 11:05:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:05:15 INFO - Running setup.py install for pep8 11:05:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:15 INFO - no previously-included directories found matching 'docs/_build' 11:05:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:05:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:05:15 INFO - Cleaning up... 11:05:15 INFO - Return code: 0 11:05:15 INFO - Running post-action listener: _resource_record_post_action 11:05:15 INFO - Running post-action listener: _start_resource_monitoring 11:05:15 INFO - Starting resource monitoring. 11:05:15 INFO - ##### 11:05:15 INFO - ##### Finished create-virtualenv step (success) 11:05:15 INFO - ##### 11:05:15 INFO - ##### 11:05:15 INFO - ##### Running install step. 11:05:15 INFO - ##### 11:05:15 INFO - Running pre-action listener: _resource_record_pre_action 11:05:15 INFO - Running main action method: install 11:05:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:15 INFO - Reading from file tmpfile_stdout 11:05:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:05:15 INFO - Reading from file tmpfile_stdout 11:05:15 INFO - Output received: 11:05:15 INFO - Usage: mozinstall [options] installer 11:05:15 INFO - Options: 11:05:15 INFO - -h, --help show this help message and exit 11:05:15 INFO - -d DEST, --destination=DEST 11:05:15 INFO - Directory to install application into. [default: 11:05:15 INFO - "/builds/slave/test"] 11:05:15 INFO - --app=APP Application being installed. [default: firefox] 11:05:15 INFO - mkdir: /builds/slave/test/build/application 11:05:15 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'] 11:05:15 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 11:05:32 INFO - Reading from file tmpfile_stdout 11:05:32 INFO - Output received: 11:05:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:05:32 INFO - Running post-action listener: _resource_record_post_action 11:05:32 INFO - ##### 11:05:32 INFO - ##### Finished install step (success) 11:05:32 INFO - ##### 11:05:32 INFO - ##### 11:05:32 INFO - ##### Running run-tests step. 11:05:32 INFO - ##### 11:05:32 INFO - Running pre-action listener: _resource_record_pre_action 11:05:32 INFO - Running main action method: run_tests 11:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:05:32 INFO - Python 2.7.3 11:05:32 INFO - Return code: 0 11:05:32 INFO - grabbing minidump binary from tooltool 11:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e6810>, '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 0x22e7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:05:32 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 11:05:32 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 11:05:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:05:32 INFO - Return code: 0 11:05:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:05:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:05:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:05:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:05:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:05:33 INFO - Return code: 0 11:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 11:05:33 INFO - Using env: {'DISPLAY': ':0', 11:05:33 INFO - 'HOME': '/home/cltbld', 11:05:33 INFO - 'LANG': 'en_US.UTF-8', 11:05:33 INFO - 'LANGUAGE': 'en_US:en', 11:05:33 INFO - 'LOGNAME': 'cltbld', 11:05:33 INFO - 'MAIL': '/var/mail/cltbld', 11:05:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:33 INFO - 'MOZ_NO_REMOTE': '1', 11:05:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:33 INFO - 'NO_EM_RESTART': '1', 11:05:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:33 INFO - 'PWD': '/builds/slave/test', 11:05:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:33 INFO - 'SHELL': '/bin/bash', 11:05:33 INFO - 'SHLVL': '1', 11:05:33 INFO - 'TERM': 'linux', 11:05:33 INFO - 'TMOUT': '86400', 11:05:33 INFO - 'USER': 'cltbld', 11:05:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226', 11:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:33 INFO - '_': '/tools/buildbot/bin/python'} 11:05:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:05:33 INFO - mozversion application_buildid: 20160506083128 11:05:33 INFO - mozversion application_changeset: 4566e5d0d25c0caf5f385c43fbab78cf4eb9a6cb 11:05:33 INFO - mozversion application_display_name: Nightly 11:05:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:05:33 INFO - mozversion application_name: Firefox 11:05:33 INFO - mozversion application_remotingname: firefox 11:05:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:05:33 INFO - mozversion application_vendor: Mozilla 11:05:33 INFO - mozversion application_version: 49.0a1 11:05:33 INFO - mozversion platform_buildid: 20160506083128 11:05:33 INFO - mozversion platform_changeset: 4566e5d0d25c0caf5f385c43fbab78cf4eb9a6cb 11:05:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:05:33 INFO - mozversion platform_version: 49.0a1 11:05:33 INFO - using testdate: 1462557933 11:05:33 INFO - actual date: 1462557933 11:05:33 INFO - starting webserver on 'localhost:47402' 11:05:33 INFO - SUITE-START | Running 2 tests 11:05:33 INFO - TEST-START | dromaeo_css 11:05:33 INFO - operating with platform_type : linux_ 11:05:33 INFO - Initialising browser for dromaeo_css test... 11:05:33 INFO - TEST-INFO | started process 28245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxX_U8/profile http://localhost:47402/getInfo.html) 11:05:37 INFO - PROCESS | 28245 | __metrics Screen width/height:1600/1200 11:05:37 INFO - PROCESS | 28245 | colorDepth:24 11:05:37 INFO - PROCESS | 28245 | Browser inner width/height: 1024/697 11:05:37 INFO - PROCESS | 28245 | __metrics 11:05:38 ERROR - PROCESS | 28245 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:05:39 INFO - TEST-INFO | 28245: exit 0 11:05:39 INFO - Browser initialized. 11:05:39 INFO - Running cycle 1/1 for dromaeo_css test... 11:05:39 INFO - TEST-INFO | started process 28326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxX_U8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:51 INFO - PROCESS | 28326 | RSS: Main: 152449024 11:05:51 INFO - PROCESS | 28326 | 11:06:42 INFO - PROCESS | 28326 | 1462558002783 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] 11:08:50 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47402/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47402/tests/dromaeo/cssquery-ext.html) 11:08:51 INFO - PROCESS | 28326 | RSS: Main: 242753536 11:08:51 INFO - PROCESS | 28326 | 11:11:54 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47402/tests/dromaeo/cssquery-ext.html (next: http://localhost:47402/tests/dromaeo/cssquery-jquery.html) 11:11:54 INFO - PROCESS | 28326 | RSS: Main: 240500736 11:11:54 INFO - PROCESS | 28326 | 11:14:56 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47402/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47402/tests/dromaeo/cssquery-mootools.html) 11:14:57 INFO - PROCESS | 28326 | RSS: Main: 247795712 11:14:57 INFO - PROCESS | 28326 | 11:17:59 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47402/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47402/tests/dromaeo/cssquery-prototype.html) 11:18:00 INFO - PROCESS | 28326 | RSS: Main: 241491968 11:18:00 INFO - PROCESS | 28326 | 11:21:02 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47402/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47402/tests/dromaeo/cssquery-yui.html) 11:21:03 INFO - PROCESS | 28326 | RSS: Main: 215695360 11:21:03 INFO - PROCESS | 28326 | 11:24:05 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47402/tests/dromaeo/cssquery-yui.html (next: http://localhost:47402/tests/dromaeo/cssquery-dojo.html) 11:24:06 INFO - PROCESS | 28326 | RSS: Main: 293462016 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | __start_tp_report 11:24:06 INFO - PROCESS | 28326 | _x_x_mozilla_page_load 11:24:06 INFO - PROCESS | 28326 | _x_x_mozilla_page_load_details 11:24:06 INFO - PROCESS | 28326 | |i|pagename|runs| 11:24:06 INFO - PROCESS | 28326 | |0;dojo.html;3188.091393952723;3194.536792165136;3224.3228921926393;3229.8546565404554;3257.299680568679;5277;5339.332583427072;5388.892222155555;5461.890762184759;5465.808696695612;5277.736113194344;5292.550133238679;5379.81170659027;5401.108817045183;5436.238926550286;4774.355462012636;4860.222364421693;4876.512348765113;4877.463479017305;5058.2412638104215;4954.108260513106;4978.452370239271;5001.299818025461;5023.171176755831;5047.47001564836;4883.389576302962;4890.095332363507;4918.852434426973;4925.014997000614;4968.87577810554;4909.803607855682;4936.80252789888;4981.327520784684;4987.551120399182;5033.471485494007;4937.580305673986;4984.3021976923255;4987.251912213197;4999.925001124986;5034.748262586856;5222.582193424517;5310.495502927216;5366.731663416853;5374.892502149935;5443.591730620219;5839.445252700986;5901.940980590182;5927.318358388798;5927.318358388798;5927.940720592782;5675.347335056439;5940.168376427304;5975.372585878464;5981.611195272293;5981.970090149522;5462.617616766828;5491.148871924858;5521.475459831309;5587.44125587438;5592.888142237173;6076.605020673642;6078.149059131725;6080.543959203077;6085.08723691441;6091.969540152271;5636.774529018875;5649.774009039593;5835.533157347402;5835.795747148914;5848.356680765112;5745.540356771448;5787.045137552341;5797.391273916178;5801.274840644919;5856.443637854397;5735.225744524436;5765.682887441147;5774.48029677331;5783.363829978699;5784.739686714108;5705.258316418922;5769.365369809318;5778.393268706809;5779.104238842986;5801.564882633819;4464.151811155935;4467.374567560544;4469.754163520973;4500.099980004013;4508.504064552896;3941.3496773032703;3960.5643379228263;3965.345717956505;3985.123272879962;4001.6198461146146;5356.46435356469;5380.865478362994;5466.835994920159;5471.097268950579;5498.917516237259;5897.380775018647;5909.556783241274;5921.496672782776;5930.080837470199;5945.672987985702;5553.555715542747;5553.666779993213;5557.555395568425;5560.471755183251;5562.16567514876;4877.5366340197625;4989.675671081441;5028.723420211923;5036.546710796046;5042.773075211551;6084.39156084388;6090.299615544269;6098.664573448415;6106.694665266719;6107.816765497042;5916.290045194604;5923.970380148072;5927.229460170151;5928.703564821828;5938.287405511366;5915.674637894957;5972.880542389041;6024.638521688713;6047.606905551125;6104.206453161239;5781.82654520365;5829.329627092939;5831.067029275296;5834.766609335579;5836;5789.884202316014;5851.912221316768;5870.383609720918;5873.060310350324;5876.059830427112;5556.972215138899;5611.466910643482;5637.971810141087;5654.6324488908085;5685.545156387397;5644.6330988485615;5653.773849045992;5658.20785090096;5666.575006874584;5671.461211184931;5501.174823776306;5568.303962004749;5572.582056345709;5579.916301255404;5585;5616.326040875121;5646.802361917313;5663.065594176915;5771.653700777967;5773.797917072882;5577.8047768327915;5579.525740311957;5587.189857470726;5588.860278492907;5596 11:24:06 INFO - PROCESS | 28326 | |1;ext.html;642.2357394700306;642.6176425027109;654.8297442664907;655.3708439897698;666.0475520006389;43054.35418468722;45326.5467345326;45327.546724532745;47653.28520072201;47734;45493.54506454935;45834;45916;46169;46229;8858.512781797015;8979.102089791035;8983.14660107292;8994.550272486382;8997.01032886382;8860.424072435271;8943.32925030622;8959.462432254053;8959.462432254053;8968.013518512958;9007.459552426875;9008.459492430475;9032;9038.322125840556;9046.819063618723;8948.463092214422;8953.641854325819;8961.507117108556;9001.774955626097;9001.909980900173;8743.08197639245;8827.646894124227;8828.984666763341;8831.69089081879;8835.867461988075;41983.1603367934;42263.366049509284;42275.57724422747;42286.57713422857;42366.36450453246;3732.496113024761;3804.752691075071;3904.726669133162;3906.921861562781;4195.958040419618;31750;32455.188620284447;32486.18784530382;32555.674443255502;32751.50872736911;4287.442632457792;4292.59220374064;4304.117655880568;4322.157179350028;4418.182636212279;301314;302478.9999999978;303140;303168;304088;57062;57509.424905750406;57641.42358576361;57666;57680.99999999916;56011;60885.391146088856;62742.68628656919;62816;66666.33333666698;17757;17762.555936101442;17849.196786144654;17926.282948681906;17937;12590.81113783294;13846.515371961934;13944.442222310994;13950.09324393911;13955.302234888215;16774.580635483966;17050.74423883643;17199.312027518758;17434.825651743322;17752.822471775376;5892.204552385373;6091.878162436727;6101.267847858286;6154.753220277994;6203.751849925952;1064.824303989833;1145.7651181507772;1160.3560024186656;1186.8931796138215;1216.9634910952686;32582.511262331085;33133.66866331354;33150.668493314755;33389.83305083459;34021.31957360888;1112.7941330853819;1186.7982442984714;1186.845710057687;1206.6561030106377;1266.050462153385;16999.830001699826;17072.402465913634;17136.742948855775;17157.31370745156;17208.96746195232;448921;450669;451087;452220;453117;54967.17549236765;55868.44131558714;55879;55997.1600425994;56125.15812262819;1315.151727135992;1429.921354325522;1460.5472303585923;1470.0811992504684;1473.8157730283715;31016.202941088886;32720.672793271762;33267.33465330728;33278.667213328525;33661.15847103744;48882;49404.25893611527;49423.75288123536;49436.258456123905;49539;331100;341137;341511;342360;342666;24819.379515512257;45624.54375456203;46418.767906160254;47432.7628361856;47503.52496474991;47494;47626.76186619045;50523.49476505188;51058;52101.478985209666;42496;43228.351574727036;43335.783321083196;43643.34534982041;44078;43182.56817431786;43298.78350608227;43400.34899476447;43599.78200109106;43762.56237437585;43333.49957608024;43970.78014609907;44057;44249.55750442454;44624.33063504115;35671.28657426785;38272.42591361076;38617.42073868838;38823.41764873473;39102;29194.41611167807;29293.707062929097;29409.11772646824;29563.85218073896;29832.85083574568 11:24:06 INFO - PROCESS | 28326 | |2;jquery.html;405.4931335830211;411.89908472424224;411.9876403707889;413.99605955557763;420.625643177572;12079.879201207985;12740.745185096292;18225.726614100782;19953.40139795805;20056.799432005675;19653.31213407531;20713.067911943963;20944.9527523624;21220.04509797059;21291;6397.648129352884;6441;6523.347665233486;6549.672516374186;6554;6235.251769787632;6479.676016199195;6501.15484986951;6503.804885853432;6508.186476690414;6495.123158373606;6526.902096468533;6534.901976470357;6536.150300460933;6539.313372095933;6441.711657668485;6504.804855854309;6506.446952009085;6529.2164940207;6538.444232240266;6176.135341052256;6278.215223097113;6317.3366796486625;6326;6398.9040164397575;23849.403764906016;24753.25740227796;25276;26041.088561900244;26103.08639197638;2514.0320976424027;2570.0747730816893;2627.3431642089477;2787.637607111083;3279.9344013119844;15422.845771542365;15499.070055796688;15598.844011559853;15664.295106720225;16317.91841040799;2042;2054.979450205509;2106.1154315187505;2144.764075951644;2174.8803815790125;57425.712871435375;94949.52525237399;95175.52412237895;95553.52223238909;96649.51675241649;17281.617470602323;17415.39046133379;17466.301347946195;17944.102794860206;18146.727799083023;33148.50277245843;33393.83303083469;33434.331313373594;33537.83231083829;33548.83225583856;10186.796264074825;10411.167106631603;10422.726682060318;10521.3687178768;10668.786624267626;8853.73438796837;8921.866172007425;8929.553522323858;9091.590878410356;9097.1812536872;8760.167784060504;8932.8660070099;8973.32700047499;9005.324600654845;9118.407303525382;3330.467125259995;3507.824608769551;3534.3523266904454;3604.8017359045502;3684.954850058243;952.3761935931975;1027.5684212630713;1112.3048094940661;1113.3097479562723;1174.8237764335247;18887.338943137198;19312.719209036844;19836.900815495832;19987.900060499604;20017.499562511053;1005.1807776661997;1007.2697294461603;1031.5564307347913;1044.9164066874632;1123.702218911989;10851.457427128613;11141.777164456666;11204.15968802343;11236.775264494665;11238.213325067167;366106;369515.3048469481;375259;506740;528921;58878;66001.66999165069;72721;94568.52715736516;102954.48522757489;996.6611352140162;1110.2062025651699;1113.6325012745774;1115.486876037032;1133.920625556203;17561.912190438965;17884.463466096036;17960.461186164437;17987.910060450136;18407.447776566725;34713.479297810045;35655.64344356523;36922.26155476929;39722.80138599288;44609.330860036476;50647.49352506575;52129.47870521246;53251;54849.45150548444;60506;8761.123887611187;9086.22767064807;9107.134822191882;9176.495292758695;9383.436993780395;12757.362131893553;13632.59102226895;13699.726005480034;13827.79258311106;14137.162168918387;11655.941720291345;12006.519739210335;12009.879901200877;12013.939930300292;12108.455119519818;11143.108551315712;11205.943970280096;11924.880751192377;12015.339156346485;12389.132760706663;12137.50796685783;12246.265224086583;12312.75374492523;12508.624741257778;12701.491940322283;9092.590833412645;9123.908760912305;9147.359684821999;9159.908400915905;9341;11595.246308989888;12238.571649992207;12303.75392492163;12327.753444930871;12330.568430104904 11:24:06 INFO - PROCESS | 28326 | |3;mootools.html;1331.3542931678141;1514.5834895403766;1541.375742824156;1693.2295805408532;1834.880732752371;8202.261796438319;8609.182127697874;8623.482591044542;8897.065808090154;8897.199252067312;8606;8821.426607270523;8821.470711757283;8825.33809964252;8848.690295839648;2020.222214447441;2276.146445083094;2335.6730057791924;2366.4912043910554;2384.8926798294033;2357.8231632627535;2359.929202123939;2363.5745565798147;2363.83453158279;2367.124164059292;2238.5858616155983;2299.9770002300015;2302.2057390200353;2302.5049614332916;2312.271634435156;2028.6652702304102;2231.4532939429782;2304.37781798915;2304.5506126305377;2314.525522267931;2224.855384400009;2248.179414513707;2250.7524172341027;2251.4371407148215;2251.853629514076;8755.212030917184;8870.068642792543;8878.067802880669;8886.289096872235;8890.59992300348;5223.817166399196;5344.732763361816;5345.679259244419;5398.568114550826;5407.324084489439;3352.5474061001696;3383.390989621867;3460.480927860816;3508.8947331580093;3536.4341705327283;961.7066794627635;1015.746063484129;1062.378508572486;1070.9946450267698;1103.6688993302057;12076.21504602207;12113.454894529856;12224.205426647328;12239.95960343363;12247.632571022794;4470.642348612103;4502.257127573914;4633.027064316464;4639.048994956026;4663.953360466419;9677.758056048655;9692.75768105803;9701.272404569685;9705.417674939526;9706.611735530641;4585.151746926763;5319;5347.973260133675;5357.43746906577;5362.624616276823;4753.239481682914;4921.680090794087;4941.555260026615;4963.6525443218625;4976.253561965734;3813.7139714521522;3827.827747751358;3895.2209558088493;3912.902177445587;3938.8818335449982;1125.4485302202027;1129.0628778114146;1137.1755477278907;1159.6926814394192;1168.4683469021575;955.1499165742495;987.4963768478128;991.7223177510309;1009.535613617744;1013.0730381700808;5602;5765;5801;5900.468957793819;5943.55423343251;940.2994768897215;974.1038244814788;976.4092723901937;979.5151400057017;1009.6920439265947;3803.3344164771056;3837.9040523987123;3971.801409929492;4020.2562525932794;4041.6766658667234;10062.647807326708;10840.186985976083;10843.67468975932;10923.563057477772;10936.945315273373;10519.94740026295;10671.146308295318;10685.626003089854;10725;10749.710034795875;8307.210814972568;8459.746207613782;8495.1080136586;8506.532140732195;8517.48895066298;5733.369329373849;5802.82591522255;5829.09649004405;5849.093390524476;5913.497352725067;9973.252006099716;10200.132988696045;10354.534045968101;10454.790904182026;10462.058414742709;10335.94832025835;10433.26967112295;10466.68599942003;10495.685129446128;10611.734706632396;6650.933490665031;7181.784546463615;7346.228645992308;7422.331990120915;7475.364594009353;8710.782230444289;8735.956320218358;8780.78048048804;8793.736187914374;8823.161799629024;7582.393408527415;7733.342665873239;7864.449488535747;7867.370610351044;7973.122956474667;7662.616869156632;7743.070831500256;7806.141324454419;7809.531428114331;7894;7220.277972202738;7225;7297.16082650502;7305.561666300039;7305.926940730737;5003.474635163256;5121.8463446096675;5220.451852555579;5299.6290259681455;5329.467053294639;4896.730679812645;5016.297718319365;5020;5063.392392912874;5215.530602245664 11:24:06 INFO - PROCESS | 28326 | |4;prototype.html;331.2943430493049;334.3163231192212;339.9796012239264;344.36464722586817;345.6664318932231;5148.9227661585055;5199.088510434155;5274.208868669697;5305.063651767106;5334.759935802888;5218.791248350071;5219.112750832358;5237.633365664405;5262.2632831403635;5280.894382112356;4110.1163249901265;4110.177964407116;4121.835126594932;4126.8142933567915;4133.7106402551835;3876.7480113792653;3920.8039598020127;4068.328725760246;4090.406891000803;4095.1400205956784;4010.919781604366;4020.4170395292663;4023.436718859362;4036.495438070241;4040.4141399497057;3866.4586957825645;4032.1734044521095;4045.0898547826796;4046.210988857174;4047.615476529725;3520.5951315598777;3593.443016332473;3595.137167079908;3598.6581274779114;3612.8916132515806;5066.468020857794;5073.771680274396;5075.264086707407;5085.110105731482;5094.083065048289;4589.586937175637;4618.838340658094;4646.465656449518;4647.907041859177;4657.510961349078;5380.139177731544;5398.568114550826;5423.972880135613;5435.809746658848;5442.12925931849;3910.354791459406;3913.706472014582;3935.153941902505;3942.7634341939574;3953.8616148434953;5605.159226116115;5661.830145095653;5675.404082571353;5757.88484230313;5773.653580785166;4008.158286759813;4013.478247827822;4017.13631569214;4020.321405913615;4029.9395509067385;4061.147159096623;4078.613271487649;4084.2648323301496;4093.85671501496;4095.7337773044655;4611.146937816515;4626.86119416418;4646.465656449484;4650.4186976627925;4658.254679251304;5284.709340986283;5463.426340234298;5471.206675032098;5479.589030822704;5510.8071217507995;1350.797380392949;1351.4188399572524;1359.4494229836932;1372.204121609484;1375.9656008599666;914.3188324698142;938.0759951447818;946.3517490519016;956.3496822160997;963.1909196275162;5090.363704536933;5119.539241468286;5147.202183661539;5284.920726189111;5338.519533242027;5560.972195138998;5603.691796951125;5612.635178713453;5625.521830644359;5629.746661400165;5136.743162841843;5309.681419114865;5313.814016509404;5322.494363035506;5358.30342055538;2863;2863.2555535560905;2863.8568071596756;2868.526693095616;2902.753265972374;5625.071863142617;5630.71846407678;5646.463585959327;5660.150977353348;5670.5463562914865;5242.397124330674;5574.442555744393;5582.218489411485;5593.46862048113;5596.776128954878;5607.4112218217315;5616.438356164351;5618.325800903836;5644.544623088887;5650.886982260414;5383.327084114486;5403.972980135074;5462.224776947429;5466.3986961435;5474.972625137008;5230.843074707765;5385.8114965976;5417.918731218956;5428.592855535771;5450.509454149145;5602.842905481501;5625.156226566048;5641.389510713229;5646.531901705504;5666.781641947001;3885.1646895917515;3885.184111336538;3903.10228647407;3930.4300876373336;3934.9803250983564;5127.87180320495;5370.9731451342495;5446.019716451076;5460.31746031746;5491.533219676372;5297.973510132425;5311.097113490639;5318.122509785842;5320.733963301742;5321.680699158062;5152.536271735562;5333.306680126511;5338;5339.691775515023;5352.330958630171;5239.842804715865;5252.4747525248695;5257.658252213594;5287.920681189708;5320.707361095177;5289.947100528945;5346.866328341823;5418.810341638024;5436.238926550207;5469.413869977662;5288.444713305047;5295.114162781217;5314.441983591667;5321.893562128813;5330.227117068081 11:24:06 INFO - PROCESS | 28326 | |5;yui.html;760.6082867323329;772.4862966127525;855.3200205836362;870.9608067636956;872.4242000279812;14957.401703931844;15573.922130389346;15624;15627.609309767262;15696.37214511421;14317.92841035796;14464.783028254558;14470.204138772364;14496.13023218605;14528.927355363236;691.1982100763116;820.1019883227856;840.1766269056328;840.8150206954491;843.2158092973532;816.8162163513192;818.6111596991441;821.117298903681;822.6585966823791;823.1315961660446;727.2836256287552;862.5342315149811;863.313665635821;864.0668078475263;864.1747131489444;862.7929296968714;876.6975393489236;881.8721285413643;885.5616469847434;886.4548302793768;641.9197600299963;642.1042645509535;642.2325321241119;642.4635429416443;642.5116911147561;14110.435582576685;14110.50613228532;14134.717305653829;14146.292685365794;14156.221407822566;13519.86480135196;13814.861851381558;13815.447382104703;13820.101693389897;13912.652183695387;11788.17482776206;11811.487775879474;12133;12140.757184856342;12315.815262771066;4452.933206001912;4455.465344158722;4541.34150548172;4606.424196975378;4613.815447382134;54284.02875683671;54334;54476.182857257176;54645.18032229559;54813;10554.577816887238;11036.503357348938;11086.667399978014;11200.831987520194;11485.310881347146;19404.320848770225;19462.416127516197;19577.314793982143;19647;19741.40775776729;8545.572721363907;8546.145385461405;8603.440776349516;8604.956975215084;8675.436096653824;4866.124097662384;4937.160682683881;4964.354633897642;5023.673461225008;5041.949580504148;3443.913902152466;3511.4206155983975;3518.05012646584;3535.7701749386724;3541.1855273287288;640.955133140685;652.1945397434165;652.7519542573791;657.4674513643964;674.5649056358621;616.7070641445367;704.7885634309687;723.3722879758018;723.4104205072849;739.4971419434728;8523.57382130891;8929.508877011696;9018.323625728097;9085.409448385833;9245.214156796614;683.8392977650249;717.7523754304757;727.9090113735783;733.8568979049141;742.3356096293787;4226.915461690749;4273.145370925828;4291.957080429218;4303.720258183208;4309.741415515079;63178.36821631725;63398;65648;66093;66751.33248667548;57543.42456575464;58093.70953145207;58105;58985;59437.405625944055;52201.2169817453;52226.73886630619;52427.73786131045;52975;54309;7831.530108193527;7960.960195198987;7997.960010199912;8046.798830029296;8125.674973001013;34230;34445.13887152741;35126.64873351234;35246.823765881;35299.470507941885;42733.78633106814;45719.54280457153;45823.31265030961;46163;46258.537414625425;10962.342259464458;11049.889501104886;11206.49570769301;11369.31784092957;11493.597724079616;11444.42777861087;11951.22317049389;12215.87805967905;12582.182158160056;14400;12696.301703406401;12900.354982250663;12925.15986460877;13925.512607058705;14015.719685606027;13093.410796513988;13796.793048104488;13802.792958105838;14192.432302708188;14309.856901431269;12703;13117.803232951705;13478.393472293967;13488.93255533716;13740.450381985009;10549.630762923261;10953.780924381626;11002.669919902095;11375.943120284346;11473.13951453661;10718.89281107179;11246.100311975186;11343.262687925258;11518.36648984314;11613.129015324053 11:24:06 INFO - PROCESS | 28326 | __end_tp_report 11:24:06 INFO - PROCESS | 28326 | __start_cc_report 11:24:06 INFO - PROCESS | 28326 | _x_x_mozilla_cycle_collect,885 11:24:06 INFO - PROCESS | 28326 | __end_cc_report 11:24:06 INFO - PROCESS | 28326 | __startTimestamp1462559046221__endTimestamp 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | ------- Summary: start ------- 11:24:06 INFO - PROCESS | 28326 | Number of tests: 6 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | [#0] dojo.html Cycles:165 Average:5418.16 Median:5587.44 stddev:618.14 (11.1%) stddev-sans-first:594.77 11:24:06 INFO - PROCESS | 28326 | Values: 3188.1 3194.5 3224.3 3229.9 3257.3 5277.0 5339.3 5388.9 5461.9 5465.8 5277.7 5292.6 5379.8 5401.1 5436.2 4774.4 4860.2 4876.5 4877.5 5058.2 4954.1 4978.5 5001.3 5023.2 5047.5 4883.4 4890.1 4918.9 4925.0 4968.9 4909.8 4936.8 4981.3 4987.6 5033.5 4937.6 4984.3 4987.3 4999.9 5034.7 5222.6 5310.5 5366.7 5374.9 5443.6 5839.4 5901.9 5927.3 5927.3 5927.9 5675.3 5940.2 5975.4 5981.6 5982.0 5462.6 5491.1 5521.5 5587.4 5592.9 6076.6 6078.1 6080.5 6085.1 6092.0 5636.8 5649.8 5835.5 5835.8 5848.4 5745.5 5787.0 5797.4 5801.3 5856.4 5735.2 5765.7 5774.5 5783.4 5784.7 5705.3 5769.4 5778.4 5779.1 5801.6 4464.2 4467.4 4469.8 4500.1 4508.5 3941.3 3960.6 3965.3 3985.1 4001.6 5356.5 5380.9 5466.8 5471.1 5498.9 5897.4 5909.6 5921.5 5930.1 5945.7 5553.6 5553.7 5557.6 5560.5 5562.2 4877.5 4989.7 5028.7 5036.5 5042.8 6084.4 6090.3 6098.7 6106.7 6107.8 5916.3 5924.0 5927.2 5928.7 5938.3 5915.7 5972.9 6024.6 6047.6 6104.2 5781.8 5829.3 5831.1 5834.8 5836.0 5789.9 5851.9 5870.4 5873.1 5876.1 5557.0 5611.5 5638.0 5654.6 5685.5 5644.6 5653.8 5658.2 5666.6 5671.5 5501.2 5568.3 5572.6 5579.9 5585.0 5616.3 5646.8 5663.1 5771.7 5773.8 5577.8 5579.5 5587.2 5588.9 5596.0 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | [#1] ext.html Cycles:180 Average:54736.62 Median:43334.64 stddev:97275.26 (224.5%) stddev-sans-first:97463.36 11:24:06 INFO - PROCESS | 28326 | Values: 642.2 642.6 654.8 655.4 666.0 43054.4 45326.5 45327.5 47653.3 47734.0 45493.5 45834.0 45916.0 46169.0 46229.0 8858.5 8979.1 8983.1 8994.6 8997.0 8860.4 8943.3 8959.5 8959.5 8968.0 9007.5 9008.5 9032.0 9038.3 9046.8 8948.5 8953.6 8961.5 9001.8 9001.9 8743.1 8827.6 8829.0 8831.7 8835.9 41983.2 42263.4 42275.6 42286.6 42366.4 3732.5 3804.8 3904.7 3906.9 4196.0 31750.0 32455.2 32486.2 32555.7 32751.5 4287.4 4292.6 4304.1 4322.2 4418.2 301314.0 302479.0 303140.0 303168.0 304088.0 57062.0 57509.4 57641.4 57666.0 57681.0 56011.0 60885.4 62742.7 62816.0 66666.3 17757.0 17762.6 17849.2 17926.3 17937.0 12590.8 13846.5 13944.4 13950.1 13955.3 16774.6 17050.7 17199.3 17434.8 17752.8 5892.2 6091.9 6101.3 6154.8 6203.8 1064.8 1145.8 1160.4 1186.9 1217.0 32582.5 33133.7 33150.7 33389.8 34021.3 1112.8 1186.8 1186.8 1206.7 1266.1 16999.8 17072.4 17136.7 17157.3 17209.0 448921.0 450669.0 451087.0 452220.0 453117.0 54967.2 55868.4 55879.0 55997.2 56125.2 1315.2 1429.9 1460.5 1470.1 1473.8 31016.2 32720.7 33267.3 33278.7 33661.2 48882.0 49404.3 49423.8 49436.3 49539.0 331100.0 341137.0 341511.0 342360.0 342666.0 24819.4 45624.5 46418.8 47432.8 47503.5 47494.0 47626.8 50523.5 51058.0 52101.5 42496.0 43228.4 43335.8 43643.3 44078.0 43182.6 43298.8 43400.3 43599.8 43762.6 43333.5 43970.8 44057.0 44249.6 44624.3 35671.3 38272.4 38617.4 38823.4 39102.0 29194.4 29293.7 29409.1 29563.9 29832.9 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | [#2] jquery.html Cycles:180 Average:28325.58 Median:14365.21 stddev:71875.27 (500.3%) stddev-sans-first:72046.32 11:24:06 INFO - PROCESS | 28326 | Values: 405.5 411.9 412.0 414.0 420.6 12079.9 12740.7 18225.7 19953.4 20056.8 19653.3 20713.1 20945.0 21220.0 21291.0 6397.6 6441.0 6523.3 6549.7 6554.0 6235.3 6479.7 6501.2 6503.8 6508.2 6495.1 6526.9 6534.9 6536.2 6539.3 6441.7 6504.8 6506.4 6529.2 6538.4 6176.1 6278.2 6317.3 6326.0 6398.9 23849.4 24753.3 25276.0 26041.1 26103.1 2514.0 2570.1 2627.3 2787.6 3279.9 15422.8 15499.1 15598.8 15664.3 16317.9 2042.0 2055.0 2106.1 2144.8 2174.9 57425.7 94949.5 95175.5 95553.5 96649.5 17281.6 17415.4 17466.3 17944.1 18146.7 33148.5 33393.8 33434.3 33537.8 33548.8 10186.8 10411.2 10422.7 10521.4 10668.8 8853.7 8921.9 8929.6 9091.6 9097.2 8760.2 8932.9 8973.3 9005.3 9118.4 3330.5 3507.8 3534.4 3604.8 3685.0 952.4 1027.6 1112.3 1113.3 1174.8 18887.3 19312.7 19836.9 19987.9 20017.5 1005.2 1007.3 1031.6 1044.9 1123.7 10851.5 11141.8 11204.2 11236.8 11238.2 366106.0 369515.3 375259.0 506740.0 528921.0 58878.0 66001.7 72721.0 94568.5 102954.5 996.7 1110.2 1113.6 1115.5 1133.9 17561.9 17884.5 17960.5 17987.9 18407.4 34713.5 35655.6 36922.3 39722.8 44609.3 50647.5 52129.5 53251.0 54849.5 60506.0 8761.1 9086.2 9107.1 9176.5 9383.4 12757.4 13632.6 13699.7 13827.8 14137.2 11655.9 12006.5 12009.9 12013.9 12108.5 11143.1 11205.9 11924.9 12015.3 12389.1 12137.5 12246.3 12312.8 12508.6 12701.5 9092.6 9123.9 9147.4 9159.9 9341.0 11595.2 12238.6 12303.8 12327.8 12330.6 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | [#3] mootools.html Cycles:180 Average:5775.55 Median:4952.60 stddev:3290.17 (66.4%) stddev-sans-first:3282.44 11:24:06 INFO - PROCESS | 28326 | Values: 1331.4 1514.6 1541.4 1693.2 1834.9 8202.3 8609.2 8623.5 8897.1 8897.2 8606.0 8821.4 8821.5 8825.3 8848.7 2020.2 2276.1 2335.7 2366.5 2384.9 2357.8 2359.9 2363.6 2363.8 2367.1 2238.6 2300.0 2302.2 2302.5 2312.3 2028.7 2231.5 2304.4 2304.6 2314.5 2224.9 2248.2 2250.8 2251.4 2251.9 8755.2 8870.1 8878.1 8886.3 8890.6 5223.8 5344.7 5345.7 5398.6 5407.3 3352.5 3383.4 3460.5 3508.9 3536.4 961.7 1015.7 1062.4 1071.0 1103.7 12076.2 12113.5 12224.2 12240.0 12247.6 4470.6 4502.3 4633.0 4639.0 4664.0 9677.8 9692.8 9701.3 9705.4 9706.6 4585.2 5319.0 5348.0 5357.4 5362.6 4753.2 4921.7 4941.6 4963.7 4976.3 3813.7 3827.8 3895.2 3912.9 3938.9 1125.4 1129.1 1137.2 1159.7 1168.5 955.1 987.5 991.7 1009.5 1013.1 5602.0 5765.0 5801.0 5900.5 5943.6 940.3 974.1 976.4 979.5 1009.7 3803.3 3837.9 3971.8 4020.3 4041.7 10062.6 10840.2 10843.7 10923.6 10936.9 10519.9 10671.1 10685.6 10725.0 10749.7 8307.2 8459.7 8495.1 8506.5 8517.5 5733.4 5802.8 5829.1 5849.1 5913.5 9973.3 10200.1 10354.5 10454.8 10462.1 10335.9 10433.3 10466.7 10495.7 10611.7 6650.9 7181.8 7346.2 7422.3 7475.4 8710.8 8736.0 8780.8 8793.7 8823.2 7582.4 7733.3 7864.4 7867.4 7973.1 7662.6 7743.1 7806.1 7809.5 7894.0 7220.3 7225.0 7297.2 7305.6 7305.9 5003.5 5121.8 5220.5 5299.6 5329.5 4896.7 5016.3 5020.0 5063.4 5215.5 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | [#4] prototype.html Cycles:180 Average:4553.18 Median:5259.96 stddev:1325.61 (25.2%) stddev-sans-first:1290.89 11:24:06 INFO - PROCESS | 28326 | Values: 331.3 334.3 340.0 344.4 345.7 5148.9 5199.1 5274.2 5305.1 5334.8 5218.8 5219.1 5237.6 5262.3 5280.9 4110.1 4110.2 4121.8 4126.8 4133.7 3876.7 3920.8 4068.3 4090.4 4095.1 4010.9 4020.4 4023.4 4036.5 4040.4 3866.5 4032.2 4045.1 4046.2 4047.6 3520.6 3593.4 3595.1 3598.7 3612.9 5066.5 5073.8 5075.3 5085.1 5094.1 4589.6 4618.8 4646.5 4647.9 4657.5 5380.1 5398.6 5424.0 5435.8 5442.1 3910.4 3913.7 3935.2 3942.8 3953.9 5605.2 5661.8 5675.4 5757.9 5773.7 4008.2 4013.5 4017.1 4020.3 4029.9 4061.1 4078.6 4084.3 4093.9 4095.7 4611.1 4626.9 4646.5 4650.4 4658.3 5284.7 5463.4 5471.2 5479.6 5510.8 1350.8 1351.4 1359.4 1372.2 1376.0 914.3 938.1 946.4 956.3 963.2 5090.4 5119.5 5147.2 5284.9 5338.5 5561.0 5603.7 5612.6 5625.5 5629.7 5136.7 5309.7 5313.8 5322.5 5358.3 2863.0 2863.3 2863.9 2868.5 2902.8 5625.1 5630.7 5646.5 5660.2 5670.5 5242.4 5574.4 5582.2 5593.5 5596.8 5607.4 5616.4 5618.3 5644.5 5650.9 5383.3 5404.0 5462.2 5466.4 5475.0 5230.8 5385.8 5417.9 5428.6 5450.5 5602.8 5625.2 5641.4 5646.5 5666.8 3885.2 3885.2 3903.1 3930.4 3935.0 5127.9 5371.0 5446.0 5460.3 5491.5 5298.0 5311.1 5318.1 5320.7 5321.7 5152.5 5333.3 5338.0 5339.7 5352.3 5239.8 5252.5 5257.7 5287.9 5320.7 5289.9 5346.9 5418.8 5436.2 5469.4 5288.4 5295.1 5314.4 5321.9 5330.2 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - PROCESS | 28326 | [#5] yui.html Cycles:180 Average:15216.44 Median:25214.87 stddev:17697.71 (70.2%) stddev-sans-first:17714.06 11:24:06 INFO - PROCESS | 28326 | Values: 760.6 772.5 855.3 871.0 872.4 14957.4 15573.9 15624.0 15627.6 15696.4 14317.9 14464.8 14470.2 14496.1 14528.9 691.2 820.1 840.2 840.8 843.2 816.8 818.6 821.1 822.7 823.1 727.3 862.5 863.3 864.1 864.2 862.8 876.7 881.9 885.6 886.5 641.9 642.1 642.2 642.5 642.5 14110.4 14110.5 14134.7 14146.3 14156.2 13519.9 13814.9 13815.4 13820.1 13912.7 11788.2 11811.5 12133.0 12140.8 12315.8 4452.9 4455.5 4541.3 4606.4 4613.8 54284.0 54334.0 54476.2 54645.2 54813.0 10554.6 11036.5 11086.7 11200.8 11485.3 19404.3 19462.4 19577.3 19647.0 19741.4 8545.6 8546.1 8603.4 8605.0 8675.4 4866.1 4937.2 4964.4 5023.7 5041.9 3443.9 3511.4 3518.1 3535.8 3541.2 641.0 652.2 652.8 657.5 674.6 616.7 704.8 723.4 723.4 739.5 8523.6 8929.5 9018.3 9085.4 9245.2 683.8 717.8 727.9 733.9 742.3 4226.9 4273.1 4292.0 4303.7 4309.7 63178.4 63398.0 65648.0 66093.0 66751.3 57543.4 58093.7 58105.0 58985.0 59437.4 52201.2 52226.7 52427.7 52975.0 54309.0 7831.5 7961.0 7998.0 8046.8 8125.7 34230.0 34445.1 35126.6 35246.8 35299.5 42733.8 45719.5 45823.3 46163.0 46258.5 10962.3 11049.9 11206.5 11369.3 11493.6 11444.4 11951.2 12215.9 12582.2 14400.0 12696.3 12900.4 12925.2 13925.5 14015.7 13093.4 13796.8 13802.8 14192.4 14309.9 12703.0 13117.8 13478.4 13488.9 13740.5 10549.6 10953.8 11002.7 11375.9 11473.1 10718.9 11246.1 11343.3 11518.4 11613.1 11:24:06 INFO - PROCESS | 28326 | -------- Summary: end -------- 11:24:06 INFO - PROCESS | 28326 | 11:24:06 INFO - TEST-INFO | 28326: exit 0 11:24:06 INFO - TEST-OK | dromaeo_css | took 1113445ms 11:24:06 INFO - TEST-START | kraken 11:24:06 INFO - operating with platform_type : linux_ 11:24:06 INFO - Initialising browser for kraken test... 11:24:06 INFO - TEST-INFO | started process 28507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_acFPg/profile http://localhost:47402/getInfo.html) 11:24:10 INFO - PROCESS | 28507 | __metrics Screen width/height:1600/1200 11:24:10 INFO - PROCESS | 28507 | colorDepth:24 11:24:10 INFO - PROCESS | 28507 | Browser inner width/height: 1024/697 11:24:10 INFO - PROCESS | 28507 | __metrics 11:24:12 ERROR - PROCESS | 28507 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:24:12 INFO - TEST-INFO | 28507: exit 0 11:24:12 INFO - Browser initialized. 11:24:12 INFO - Running cycle 1/1 for kraken test... 11:24:12 INFO - TEST-INFO | started process 28588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_acFPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:24 INFO - PROCESS | 28588 | RSS: Main: 152244224 11:24:24 INFO - PROCESS | 28588 | 11:24:27 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47402/tests/kraken/driver.html?testName=audio-beat-detection) 11:24:27 INFO - PROCESS | 28588 | RSS: Main: 208113664 11:24:27 INFO - PROCESS | 28588 | 11:24:30 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47402/tests/kraken/driver.html?testName=audio-dft) 11:24:31 INFO - PROCESS | 28588 | RSS: Main: 197976064 11:24:31 INFO - PROCESS | 28588 | 11:24:34 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47402/tests/kraken/driver.html?testName=audio-fft) 11:24:34 INFO - PROCESS | 28588 | RSS: Main: 265338880 11:24:34 INFO - PROCESS | 28588 | 11:24:37 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47402/tests/kraken/driver.html?testName=audio-oscillator) 11:24:37 INFO - PROCESS | 28588 | RSS: Main: 175116288 11:24:37 INFO - PROCESS | 28588 | 11:24:39 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47402/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:40 INFO - PROCESS | 28588 | RSS: Main: 178888704 11:24:40 INFO - PROCESS | 28588 | 11:24:43 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47402/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:44 INFO - PROCESS | 28588 | RSS: Main: 215416832 11:24:44 INFO - PROCESS | 28588 | 11:24:47 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47402/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:48 INFO - PROCESS | 28588 | RSS: Main: 215846912 11:24:48 INFO - PROCESS | 28588 | 11:24:50 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47402/tests/kraken/driver.html?testName=json-parse-financial) 11:24:51 INFO - PROCESS | 28588 | RSS: Main: 215736320 11:24:51 INFO - PROCESS | 28588 | 11:24:52 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47402/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:53 INFO - PROCESS | 28588 | RSS: Main: 203837440 11:24:53 INFO - PROCESS | 28588 | 11:24:55 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:55 INFO - PROCESS | 28588 | RSS: Main: 206249984 11:24:55 INFO - PROCESS | 28588 | 11:24:57 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:24:58 INFO - PROCESS | 28588 | RSS: Main: 216633344 11:24:58 INFO - PROCESS | 28588 | 11:25:01 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:01 INFO - PROCESS | 28588 | RSS: Main: 224854016 11:25:01 INFO - PROCESS | 28588 | 11:25:04 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:05 INFO - PROCESS | 28588 | RSS: Main: 220024832 11:25:05 INFO - PROCESS | 28588 | 11:25:06 INFO - PROCESS | 28588 | Cycle 1(1): loaded http://localhost:47402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47402/tests/kraken/driver.html?testName=ai-astar) 11:25:07 INFO - PROCESS | 28588 | RSS: Main: 266051584 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | __start_tp_report 11:25:07 INFO - PROCESS | 28588 | _x_x_mozilla_page_load 11:25:07 INFO - PROCESS | 28588 | _x_x_mozilla_page_load_details 11:25:07 INFO - PROCESS | 28588 | |i|pagename|runs| 11:25:07 INFO - PROCESS | 28588 | |0;ai-astar;112;104;112;109;110;110;109;111;110;111 11:25:07 INFO - PROCESS | 28588 | |1;audio-beat-detection;161;125;162;178;127;154;149;128;202;126 11:25:07 INFO - PROCESS | 28588 | |2;audio-dft;162;161;162;160;161;161;162;162;161;163 11:25:07 INFO - PROCESS | 28588 | |3;audio-fft;76;75;74;126;76;75;76;75;129;74 11:25:07 INFO - PROCESS | 28588 | |4;audio-oscillator;92;93;119;91;91;92;133;93;91;126 11:25:07 INFO - PROCESS | 28588 | |5;imaging-gaussian-blur;117;116;116;118;117;118;117;118;117;118 11:25:07 INFO - PROCESS | 28588 | |6;imaging-darkroom;145;146;145;145;145;146;145;146;145;145 11:25:07 INFO - PROCESS | 28588 | |7;imaging-desaturate;94;95;94;95;95;95;94;95;96;94 11:25:07 INFO - PROCESS | 28588 | |8;json-parse-financial;57;57;58;57;57;58;59;73;55;55 11:25:07 INFO - PROCESS | 28588 | |9;json-stringify-tinderbox;60;60;61;60;62;61;61;61;61;60 11:25:07 INFO - PROCESS | 28588 | |10;stanford-crypto-aes;79;82;80;79;78;80;85;80;80;80 11:25:07 INFO - PROCESS | 28588 | |11;stanford-crypto-ccm;126;125;124;136;126;129;124;131;172;128 11:25:07 INFO - PROCESS | 28588 | |12;stanford-crypto-pbkdf2;170;170;171;166;170;164;167;165;167;165 11:25:07 INFO - PROCESS | 28588 | |13;stanford-crypto-sha256-iterative;66;68;66;65;64;64;64;64;64;64 11:25:07 INFO - PROCESS | 28588 | __end_tp_report 11:25:07 INFO - PROCESS | 28588 | __start_cc_report 11:25:07 INFO - PROCESS | 28588 | _x_x_mozilla_cycle_collect,1602 11:25:07 INFO - PROCESS | 28588 | __end_cc_report 11:25:07 INFO - PROCESS | 28588 | __startTimestamp1462559107033__endTimestamp 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | ------- Summary: start ------- 11:25:07 INFO - PROCESS | 28588 | Number of tests: 14 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.30 (2.1%) stddev-sans-first:2.30 11:25:07 INFO - PROCESS | 28588 | Values: 112.0 104.0 112.0 109.0 110.0 110.0 109.0 111.0 110.0 111.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:157.50 stddev:25.75 (16.4%) stddev-sans-first:27.07 11:25:07 INFO - PROCESS | 28588 | Values: 161.0 125.0 162.0 178.0 127.0 154.0 149.0 128.0 202.0 126.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 11:25:07 INFO - PROCESS | 28588 | Values: 162.0 161.0 162.0 160.0 161.0 161.0 162.0 162.0 161.0 163.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#3] audio-fft Cycles:10 Average:85.60 Median:75.00 stddev:22.11 (29.5%) stddev-sans-first:23.17 11:25:07 INFO - PROCESS | 28588 | Values: 76.0 75.0 74.0 126.0 76.0 75.0 76.0 75.0 129.0 74.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:91.50 stddev:16.84 (18.4%) stddev-sans-first:17.46 11:25:07 INFO - PROCESS | 28588 | Values: 92.0 93.0 119.0 91.0 91.0 92.0 133.0 93.0 91.0 126.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 11:25:07 INFO - PROCESS | 28588 | Values: 117.0 116.0 116.0 118.0 117.0 118.0 117.0 118.0 117.0 118.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:25:07 INFO - PROCESS | 28588 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 11:25:07 INFO - PROCESS | 28588 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 96.0 94.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:5.21 (9.1%) stddev-sans-first:5.49 11:25:07 INFO - PROCESS | 28588 | Values: 57.0 57.0 58.0 57.0 57.0 58.0 59.0 73.0 55.0 55.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 11:25:07 INFO - PROCESS | 28588 | Values: 60.0 60.0 61.0 60.0 62.0 61.0 61.0 61.0 61.0 60.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:1.95 (2.4%) stddev-sans-first:2.01 11:25:07 INFO - PROCESS | 28588 | Values: 79.0 82.0 80.0 79.0 78.0 80.0 85.0 80.0 80.0 80.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:128.50 stddev:14.49 (11.3%) stddev-sans-first:15.21 11:25:07 INFO - PROCESS | 28588 | Values: 126.0 125.0 124.0 136.0 126.0 129.0 124.0 131.0 172.0 128.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:168.50 stddev:2.55 (1.5%) stddev-sans-first:2.54 11:25:07 INFO - PROCESS | 28588 | Values: 170.0 170.0 171.0 166.0 170.0 164.0 167.0 165.0 167.0 165.0 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - PROCESS | 28588 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:1.37 (2.1%) stddev-sans-first:1.39 11:25:07 INFO - PROCESS | 28588 | Values: 66.0 68.0 66.0 65.0 64.0 64.0 64.0 64.0 64.0 64.0 11:25:07 INFO - PROCESS | 28588 | -------- Summary: end -------- 11:25:07 INFO - PROCESS | 28588 | 11:25:07 INFO - TEST-INFO | 28588: exit 0 11:25:08 INFO - TEST-OK | kraken | took 61110ms 11:25:08 INFO - SUITE-END | took 1174s 11:25:08 INFO - Completed test suite (00:19:34) 11:25:08 INFO - javascript benchmark 11:25:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.091393952723, 3194.536792165136, 3224.3228921926393, 3229.8546565404554, 3257.299680568679, 5277.0, 5339.332583427072, 5388.892222155555, 5461.890762184759, 5465.808696695612, 5277.736113194344, 5292.550133238679, 5379.81170659027, 5401.108817045183, 5436.238926550286, 4774.355462012636, 4860.222364421693, 4876.512348765113, 4877.463479017305, 5058.2412638104215, 4954.108260513106, 4978.452370239271, 5001.299818025461, 5023.171176755831, 5047.47001564836, 4883.389576302962, 4890.095332363507, 4918.852434426973, 4925.014997000614, 4968.87577810554, 4909.803607855682, 4936.80252789888, 4981.327520784684, 4987.551120399182, 5033.471485494007, 4937.580305673986, 4984.3021976923255, 4987.251912213197, 4999.925001124986, 5034.748262586856, 5222.582193424517, 5310.495502927216, 5366.731663416853, 5374.892502149935, 5443.591730620219, 5839.445252700986, 5901.940980590182, 5927.318358388798, 5927.318358388798, 5927.940720592782, 5675.347335056439, 5940.168376427304, 5975.372585878464, 5981.611195272293, 5981.970090149522, 5462.617616766828, 5491.148871924858, 5521.475459831309, 5587.44125587438, 5592.888142237173, 6076.605020673642, 6078.149059131725, 6080.543959203077, 6085.08723691441, 6091.969540152271, 5636.774529018875, 5649.774009039593, 5835.533157347402, 5835.795747148914, 5848.356680765112, 5745.540356771448, 5787.045137552341, 5797.391273916178, 5801.274840644919, 5856.443637854397, 5735.225744524436, 5765.682887441147, 5774.48029677331, 5783.363829978699, 5784.739686714108, 5705.258316418922, 5769.365369809318, 5778.393268706809, 5779.104238842986, 5801.564882633819, 4464.151811155935, 4467.374567560544, 4469.754163520973, 4500.099980004013, 4508.504064552896, 3941.3496773032703, 3960.5643379228263, 3965.345717956505, 3985.123272879962, 4001.6198461146146, 5356.46435356469, 5380.865478362994, 5466.835994920159, 5471.097268950579, 5498.917516237259, 5897.380775018647, 5909.556783241274, 5921.496672782776, 5930.080837470199, 5945.672987985702, 5553.555715542747, 5553.666779993213, 5557.555395568425, 5560.471755183251, 5562.16567514876, 4877.5366340197625, 4989.675671081441, 5028.723420211923, 5036.546710796046, 5042.773075211551, 6084.39156084388, 6090.299615544269, 6098.664573448415, 6106.694665266719, 6107.816765497042, 5916.290045194604, 5923.970380148072, 5927.229460170151, 5928.703564821828, 5938.287405511366, 5915.674637894957, 5972.880542389041, 6024.638521688713, 6047.606905551125, 6104.206453161239, 5781.82654520365, 5829.329627092939, 5831.067029275296, 5834.766609335579, 5836.0, 5789.884202316014, 5851.912221316768, 5870.383609720918, 5873.060310350324, 5876.059830427112, 5556.972215138899, 5611.466910643482, 5637.971810141087, 5654.6324488908085, 5685.545156387397, 5644.6330988485615, 5653.773849045992, 5658.20785090096, 5666.575006874584, 5671.461211184931, 5501.174823776306, 5568.303962004749, 5572.582056345709, 5579.916301255404, 5585.0, 5616.326040875121, 5646.802361917313, 5663.065594176915, 5771.653700777967, 5773.797917072882, 5577.8047768327915, 5579.525740311957, 5587.189857470726, 5588.860278492907, 5596.0], "value": 5376.86672680194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.2357394700306, 642.6176425027109, 654.8297442664907, 655.3708439897698, 666.0475520006389, 43054.35418468722, 45326.5467345326, 45327.546724532745, 47653.28520072201, 47734.0, 45493.54506454935, 45834.0, 45916.0, 46169.0, 46229.0, 8858.512781797015, 8979.102089791035, 8983.14660107292, 8994.550272486382, 8997.01032886382, 8860.424072435271, 8943.32925030622, 8959.462432254053, 8959.462432254053, 8968.013518512958, 9007.459552426875, 9008.459492430475, 9032.0, 9038.322125840556, 9046.819063618723, 8948.463092214422, 8953.641854325819, 8961.507117108556, 9001.774955626097, 9001.909980900173, 8743.08197639245, 8827.646894124227, 8828.984666763341, 8831.69089081879, 8835.867461988075, 41983.1603367934, 42263.366049509284, 42275.57724422747, 42286.57713422857, 42366.36450453246, 3732.496113024761, 3804.752691075071, 3904.726669133162, 3906.921861562781, 4195.958040419618, 31750.0, 32455.188620284447, 32486.18784530382, 32555.674443255502, 32751.50872736911, 4287.442632457792, 4292.59220374064, 4304.117655880568, 4322.157179350028, 4418.182636212279, 301314.0, 302478.9999999978, 303140.0, 303168.0, 304088.0, 57062.0, 57509.424905750406, 57641.42358576361, 57666.0, 57680.99999999916, 56011.0, 60885.391146088856, 62742.68628656919, 62816.0, 66666.33333666698, 17757.0, 17762.555936101442, 17849.196786144654, 17926.282948681906, 17937.0, 12590.81113783294, 13846.515371961934, 13944.442222310994, 13950.09324393911, 13955.302234888215, 16774.580635483966, 17050.74423883643, 17199.312027518758, 17434.825651743322, 17752.822471775376, 5892.204552385373, 6091.878162436727, 6101.267847858286, 6154.753220277994, 6203.751849925952, 1064.824303989833, 1145.7651181507772, 1160.3560024186656, 1186.8931796138215, 1216.9634910952686, 32582.511262331085, 33133.66866331354, 33150.668493314755, 33389.83305083459, 34021.31957360888, 1112.7941330853819, 1186.7982442984714, 1186.845710057687, 1206.6561030106377, 1266.050462153385, 16999.830001699826, 17072.402465913634, 17136.742948855775, 17157.31370745156, 17208.96746195232, 448921.0, 450669.0, 451087.0, 452220.0, 453117.0, 54967.17549236765, 55868.44131558714, 55879.0, 55997.1600425994, 56125.15812262819, 1315.151727135992, 1429.921354325522, 1460.5472303585923, 1470.0811992504684, 1473.8157730283715, 31016.202941088886, 32720.672793271762, 33267.33465330728, 33278.667213328525, 33661.15847103744, 48882.0, 49404.25893611527, 49423.75288123536, 49436.258456123905, 49539.0, 331100.0, 341137.0, 341511.0, 342360.0, 342666.0, 24819.379515512257, 45624.54375456203, 46418.767906160254, 47432.7628361856, 47503.52496474991, 47494.0, 47626.76186619045, 50523.49476505188, 51058.0, 52101.478985209666, 42496.0, 43228.351574727036, 43335.783321083196, 43643.34534982041, 44078.0, 43182.56817431786, 43298.78350608227, 43400.34899476447, 43599.78200109106, 43762.56237437585, 43333.49957608024, 43970.78014609907, 44057.0, 44249.55750442454, 44624.33063504115, 35671.28657426785, 38272.42591361076, 38617.42073868838, 38823.41764873473, 39102.0, 29194.41611167807, 29293.707062929097, 29409.11772646824, 29563.85218073896, 29832.85083574568], "value": 20448.817083677957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.4931335830211, 411.89908472424224, 411.9876403707889, 413.99605955557763, 420.625643177572, 12079.879201207985, 12740.745185096292, 18225.726614100782, 19953.40139795805, 20056.799432005675, 19653.31213407531, 20713.067911943963, 20944.9527523624, 21220.04509797059, 21291.0, 6397.648129352884, 6441.0, 6523.347665233486, 6549.672516374186, 6554.0, 6235.251769787632, 6479.676016199195, 6501.15484986951, 6503.804885853432, 6508.186476690414, 6495.123158373606, 6526.902096468533, 6534.901976470357, 6536.150300460933, 6539.313372095933, 6441.711657668485, 6504.804855854309, 6506.446952009085, 6529.2164940207, 6538.444232240266, 6176.135341052256, 6278.215223097113, 6317.3366796486625, 6326.0, 6398.9040164397575, 23849.403764906016, 24753.25740227796, 25276.0, 26041.088561900244, 26103.08639197638, 2514.0320976424027, 2570.0747730816893, 2627.3431642089477, 2787.637607111083, 3279.9344013119844, 15422.845771542365, 15499.070055796688, 15598.844011559853, 15664.295106720225, 16317.91841040799, 2042.0, 2054.979450205509, 2106.1154315187505, 2144.764075951644, 2174.8803815790125, 57425.712871435375, 94949.52525237399, 95175.52412237895, 95553.52223238909, 96649.51675241649, 17281.617470602323, 17415.39046133379, 17466.301347946195, 17944.102794860206, 18146.727799083023, 33148.50277245843, 33393.83303083469, 33434.331313373594, 33537.83231083829, 33548.83225583856, 10186.796264074825, 10411.167106631603, 10422.726682060318, 10521.3687178768, 10668.786624267626, 8853.73438796837, 8921.866172007425, 8929.553522323858, 9091.590878410356, 9097.1812536872, 8760.167784060504, 8932.8660070099, 8973.32700047499, 9005.324600654845, 9118.407303525382, 3330.467125259995, 3507.824608769551, 3534.3523266904454, 3604.8017359045502, 3684.954850058243, 952.3761935931975, 1027.5684212630713, 1112.3048094940661, 1113.3097479562723, 1174.8237764335247, 18887.338943137198, 19312.719209036844, 19836.900815495832, 19987.900060499604, 20017.499562511053, 1005.1807776661997, 1007.2697294461603, 1031.5564307347913, 1044.9164066874632, 1123.702218911989, 10851.457427128613, 11141.777164456666, 11204.15968802343, 11236.775264494665, 11238.213325067167, 366106.0, 369515.3048469481, 375259.0, 506740.0, 528921.0, 58878.0, 66001.66999165069, 72721.0, 94568.52715736516, 102954.48522757489, 996.6611352140162, 1110.2062025651699, 1113.6325012745774, 1115.486876037032, 1133.920625556203, 17561.912190438965, 17884.463466096036, 17960.461186164437, 17987.910060450136, 18407.447776566725, 34713.479297810045, 35655.64344356523, 36922.26155476929, 39722.80138599288, 44609.330860036476, 50647.49352506575, 52129.47870521246, 53251.0, 54849.45150548444, 60506.0, 8761.123887611187, 9086.22767064807, 9107.134822191882, 9176.495292758695, 9383.436993780395, 12757.362131893553, 13632.59102226895, 13699.726005480034, 13827.79258311106, 14137.162168918387, 11655.941720291345, 12006.519739210335, 12009.879901200877, 12013.939930300292, 12108.455119519818, 11143.108551315712, 11205.943970280096, 11924.880751192377, 12015.339156346485, 12389.132760706663, 12137.50796685783, 12246.265224086583, 12312.75374492523, 12508.624741257778, 12701.491940322283, 9092.590833412645, 9123.908760912305, 9147.359684821999, 9159.908400915905, 9341.0, 11595.246308989888, 12238.571649992207, 12303.75392492163, 12327.753444930871, 12330.568430104904], "value": 10433.882508996245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.3542931678141, 1514.5834895403766, 1541.375742824156, 1693.2295805408532, 1834.880732752371, 8202.261796438319, 8609.182127697874, 8623.482591044542, 8897.065808090154, 8897.199252067312, 8606.0, 8821.426607270523, 8821.470711757283, 8825.33809964252, 8848.690295839648, 2020.222214447441, 2276.146445083094, 2335.6730057791924, 2366.4912043910554, 2384.8926798294033, 2357.8231632627535, 2359.929202123939, 2363.5745565798147, 2363.83453158279, 2367.124164059292, 2238.5858616155983, 2299.9770002300015, 2302.2057390200353, 2302.5049614332916, 2312.271634435156, 2028.6652702304102, 2231.4532939429782, 2304.37781798915, 2304.5506126305377, 2314.525522267931, 2224.855384400009, 2248.179414513707, 2250.7524172341027, 2251.4371407148215, 2251.853629514076, 8755.212030917184, 8870.068642792543, 8878.067802880669, 8886.289096872235, 8890.59992300348, 5223.817166399196, 5344.732763361816, 5345.679259244419, 5398.568114550826, 5407.324084489439, 3352.5474061001696, 3383.390989621867, 3460.480927860816, 3508.8947331580093, 3536.4341705327283, 961.7066794627635, 1015.746063484129, 1062.378508572486, 1070.9946450267698, 1103.6688993302057, 12076.21504602207, 12113.454894529856, 12224.205426647328, 12239.95960343363, 12247.632571022794, 4470.642348612103, 4502.257127573914, 4633.027064316464, 4639.048994956026, 4663.953360466419, 9677.758056048655, 9692.75768105803, 9701.272404569685, 9705.417674939526, 9706.611735530641, 4585.151746926763, 5319.0, 5347.973260133675, 5357.43746906577, 5362.624616276823, 4753.239481682914, 4921.680090794087, 4941.555260026615, 4963.6525443218625, 4976.253561965734, 3813.7139714521522, 3827.827747751358, 3895.2209558088493, 3912.902177445587, 3938.8818335449982, 1125.4485302202027, 1129.0628778114146, 1137.1755477278907, 1159.6926814394192, 1168.4683469021575, 955.1499165742495, 987.4963768478128, 991.7223177510309, 1009.535613617744, 1013.0730381700808, 5602.0, 5765.0, 5801.0, 5900.468957793819, 5943.55423343251, 940.2994768897215, 974.1038244814788, 976.4092723901937, 979.5151400057017, 1009.6920439265947, 3803.3344164771056, 3837.9040523987123, 3971.801409929492, 4020.2562525932794, 4041.6766658667234, 10062.647807326708, 10840.186985976083, 10843.67468975932, 10923.563057477772, 10936.945315273373, 10519.94740026295, 10671.146308295318, 10685.626003089854, 10725.0, 10749.710034795875, 8307.210814972568, 8459.746207613782, 8495.1080136586, 8506.532140732195, 8517.48895066298, 5733.369329373849, 5802.82591522255, 5829.09649004405, 5849.093390524476, 5913.497352725067, 9973.252006099716, 10200.132988696045, 10354.534045968101, 10454.790904182026, 10462.058414742709, 10335.94832025835, 10433.26967112295, 10466.68599942003, 10495.685129446128, 10611.734706632396, 6650.933490665031, 7181.784546463615, 7346.228645992308, 7422.331990120915, 7475.364594009353, 8710.782230444289, 8735.956320218358, 8780.78048048804, 8793.736187914374, 8823.161799629024, 7582.393408527415, 7733.342665873239, 7864.449488535747, 7867.370610351044, 7973.122956474667, 7662.616869156632, 7743.070831500256, 7806.141324454419, 7809.531428114331, 7894.0, 7220.277972202738, 7225.0, 7297.16082650502, 7305.561666300039, 7305.926940730737, 5003.474635163256, 5121.8463446096675, 5220.451852555579, 5299.6290259681455, 5329.467053294639, 4896.730679812645, 5016.297718319365, 5020.0, 5063.392392912874, 5215.530602245664], "value": 4606.952194917722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.2943430493049, 334.3163231192212, 339.9796012239264, 344.36464722586817, 345.6664318932231, 5148.9227661585055, 5199.088510434155, 5274.208868669697, 5305.063651767106, 5334.759935802888, 5218.791248350071, 5219.112750832358, 5237.633365664405, 5262.2632831403635, 5280.894382112356, 4110.1163249901265, 4110.177964407116, 4121.835126594932, 4126.8142933567915, 4133.7106402551835, 3876.7480113792653, 3920.8039598020127, 4068.328725760246, 4090.406891000803, 4095.1400205956784, 4010.919781604366, 4020.4170395292663, 4023.436718859362, 4036.495438070241, 4040.4141399497057, 3866.4586957825645, 4032.1734044521095, 4045.0898547826796, 4046.210988857174, 4047.615476529725, 3520.5951315598777, 3593.443016332473, 3595.137167079908, 3598.6581274779114, 3612.8916132515806, 5066.468020857794, 5073.771680274396, 5075.264086707407, 5085.110105731482, 5094.083065048289, 4589.586937175637, 4618.838340658094, 4646.465656449518, 4647.907041859177, 4657.510961349078, 5380.139177731544, 5398.568114550826, 5423.972880135613, 5435.809746658848, 5442.12925931849, 3910.354791459406, 3913.706472014582, 3935.153941902505, 3942.7634341939574, 3953.8616148434953, 5605.159226116115, 5661.830145095653, 5675.404082571353, 5757.88484230313, 5773.653580785166, 4008.158286759813, 4013.478247827822, 4017.13631569214, 4020.321405913615, 4029.9395509067385, 4061.147159096623, 4078.613271487649, 4084.2648323301496, 4093.85671501496, 4095.7337773044655, 4611.146937816515, 4626.86119416418, 4646.465656449484, 4650.4186976627925, 4658.254679251304, 5284.709340986283, 5463.426340234298, 5471.206675032098, 5479.589030822704, 5510.8071217507995, 1350.797380392949, 1351.4188399572524, 1359.4494229836932, 1372.204121609484, 1375.9656008599666, 914.3188324698142, 938.0759951447818, 946.3517490519016, 956.3496822160997, 963.1909196275162, 5090.363704536933, 5119.539241468286, 5147.202183661539, 5284.920726189111, 5338.519533242027, 5560.972195138998, 5603.691796951125, 5612.635178713453, 5625.521830644359, 5629.746661400165, 5136.743162841843, 5309.681419114865, 5313.814016509404, 5322.494363035506, 5358.30342055538, 2863.0, 2863.2555535560905, 2863.8568071596756, 2868.526693095616, 2902.753265972374, 5625.071863142617, 5630.71846407678, 5646.463585959327, 5660.150977353348, 5670.5463562914865, 5242.397124330674, 5574.442555744393, 5582.218489411485, 5593.46862048113, 5596.776128954878, 5607.4112218217315, 5616.438356164351, 5618.325800903836, 5644.544623088887, 5650.886982260414, 5383.327084114486, 5403.972980135074, 5462.224776947429, 5466.3986961435, 5474.972625137008, 5230.843074707765, 5385.8114965976, 5417.918731218956, 5428.592855535771, 5450.509454149145, 5602.842905481501, 5625.156226566048, 5641.389510713229, 5646.531901705504, 5666.781641947001, 3885.1646895917515, 3885.184111336538, 3903.10228647407, 3930.4300876373336, 3934.9803250983564, 5127.87180320495, 5370.9731451342495, 5446.019716451076, 5460.31746031746, 5491.533219676372, 5297.973510132425, 5311.097113490639, 5318.122509785842, 5320.733963301742, 5321.680699158062, 5152.536271735562, 5333.306680126511, 5338.0, 5339.691775515023, 5352.330958630171, 5239.842804715865, 5252.4747525248695, 5257.658252213594, 5287.920681189708, 5320.707361095177, 5289.947100528945, 5346.866328341823, 5418.810341638024, 5436.238926550207, 5469.413869977662, 5288.444713305047, 5295.114162781217, 5314.441983591667, 5321.893562128813, 5330.227117068081], "value": 4134.684711370183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.6082867323329, 772.4862966127525, 855.3200205836362, 870.9608067636956, 872.4242000279812, 14957.401703931844, 15573.922130389346, 15624.0, 15627.609309767262, 15696.37214511421, 14317.92841035796, 14464.783028254558, 14470.204138772364, 14496.13023218605, 14528.927355363236, 691.1982100763116, 820.1019883227856, 840.1766269056328, 840.8150206954491, 843.2158092973532, 816.8162163513192, 818.6111596991441, 821.117298903681, 822.6585966823791, 823.1315961660446, 727.2836256287552, 862.5342315149811, 863.313665635821, 864.0668078475263, 864.1747131489444, 862.7929296968714, 876.6975393489236, 881.8721285413643, 885.5616469847434, 886.4548302793768, 641.9197600299963, 642.1042645509535, 642.2325321241119, 642.4635429416443, 642.5116911147561, 14110.435582576685, 14110.50613228532, 14134.717305653829, 14146.292685365794, 14156.221407822566, 13519.86480135196, 13814.861851381558, 13815.447382104703, 13820.101693389897, 13912.652183695387, 11788.17482776206, 11811.487775879474, 12133.0, 12140.757184856342, 12315.815262771066, 4452.933206001912, 4455.465344158722, 4541.34150548172, 4606.424196975378, 4613.815447382134, 54284.02875683671, 54334.0, 54476.182857257176, 54645.18032229559, 54813.0, 10554.577816887238, 11036.503357348938, 11086.667399978014, 11200.831987520194, 11485.310881347146, 19404.320848770225, 19462.416127516197, 19577.314793982143, 19647.0, 19741.40775776729, 8545.572721363907, 8546.145385461405, 8603.440776349516, 8604.956975215084, 8675.436096653824, 4866.124097662384, 4937.160682683881, 4964.354633897642, 5023.673461225008, 5041.949580504148, 3443.913902152466, 3511.4206155983975, 3518.05012646584, 3535.7701749386724, 3541.1855273287288, 640.955133140685, 652.1945397434165, 652.7519542573791, 657.4674513643964, 674.5649056358621, 616.7070641445367, 704.7885634309687, 723.3722879758018, 723.4104205072849, 739.4971419434728, 8523.57382130891, 8929.508877011696, 9018.323625728097, 9085.409448385833, 9245.214156796614, 683.8392977650249, 717.7523754304757, 727.9090113735783, 733.8568979049141, 742.3356096293787, 4226.915461690749, 4273.145370925828, 4291.957080429218, 4303.720258183208, 4309.741415515079, 63178.36821631725, 63398.0, 65648.0, 66093.0, 66751.33248667548, 57543.42456575464, 58093.70953145207, 58105.0, 58985.0, 59437.405625944055, 52201.2169817453, 52226.73886630619, 52427.73786131045, 52975.0, 54309.0, 7831.530108193527, 7960.960195198987, 7997.960010199912, 8046.798830029296, 8125.674973001013, 34230.0, 34445.13887152741, 35126.64873351234, 35246.823765881, 35299.470507941885, 42733.78633106814, 45719.54280457153, 45823.31265030961, 46163.0, 46258.537414625425, 10962.342259464458, 11049.889501104886, 11206.49570769301, 11369.31784092957, 11493.597724079616, 11444.42777861087, 11951.22317049389, 12215.87805967905, 12582.182158160056, 14400.0, 12696.301703406401, 12900.354982250663, 12925.15986460877, 13925.512607058705, 14015.719685606027, 13093.410796513988, 13796.793048104488, 13802.792958105838, 14192.432302708188, 14309.856901431269, 12703.0, 13117.803232951705, 13478.393472293967, 13488.93255533716, 13740.450381985009, 10549.630762923261, 10953.780924381626, 11002.669919902095, 11375.943120284346, 11473.13951453661, 10718.89281107179, 11246.100311975186, 11343.262687925258, 11518.36648984314, 11613.129015324053], "value": 6892.7848823373215, "unit": "score"}], "name": "dromaeo_css", "value": 7294.415365402003, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 112.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 162.0, 178.0, 127.0, 154.0, 149.0, 128.0, 202.0, 126.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 126.0, 76.0, 75.0, 76.0, 75.0, 129.0, 74.0], "value": 85.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 119.0, 91.0, 91.0, 92.0, 133.0, 93.0, 91.0, 126.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 57.0, 58.0, 59.0, 73.0, 55.0, 55.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 80.0, 79.0, 78.0, 80.0, 85.0, 80.0, 80.0, 80.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 124.0, 136.0, 126.0, 129.0, 124.0, 131.0, 172.0, 128.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 171.0, 166.0, 170.0, 164.0, 167.0, 165.0, 167.0, 165.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1531.5, "alertThreshold": 2.0}]} 11:25:08 INFO - Return code: 0 11:25:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:25:08 ERROR - # TBPL SUCCESS # 11:25:08 INFO - Running post-action listener: _resource_record_post_action 11:25:08 INFO - ##### 11:25:08 INFO - ##### Finished run-tests step (success) 11:25:08 INFO - ##### 11:25:08 INFO - Running post-run listener: _resource_record_post_run 11:25:09 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 536100864; Read time: 0; Write time: 503380 11:25:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244871168; Read time: 0; Write time: 304996 11:25:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291229696; Read time: 0; Write time: 198384 11:25:09 INFO - Running post-run listener: _upload_blobber_files 11:25:09 INFO - Blob upload gear active. 11:25:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:25:09 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 11:25:09 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:25:09 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:25:09 INFO - (blobuploader) - INFO - Open directory for files ... 11:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:25:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:11 INFO - (blobuploader) - INFO - Done attempting. 11:25:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:25:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:12 INFO - (blobuploader) - INFO - Done attempting. 11:25:12 INFO - (blobuploader) - INFO - Iteration through files over. 11:25:12 INFO - Return code: 0 11:25:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:25:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:25:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb57a4b12301393badffd146e45390ff7f3ba2b509dc836dd75680366cac3cc1dc55dfd4eb73e2953c75f48ed27eff0b93b6c03f65d0be2430efb77239b96c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94563c2cbfae8221a240149f555f248d139d73f660bbfc9ef3ccf88d90078e4d56ee95946c180b27d7d9a279957330c12d53b1eaeff1e60d2ce56aecf4c0d209"} 11:25:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:25:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:25:12 INFO - Contents: 11:25:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb57a4b12301393badffd146e45390ff7f3ba2b509dc836dd75680366cac3cc1dc55dfd4eb73e2953c75f48ed27eff0b93b6c03f65d0be2430efb77239b96c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94563c2cbfae8221a240149f555f248d139d73f660bbfc9ef3ccf88d90078e4d56ee95946c180b27d7d9a279957330c12d53b1eaeff1e60d2ce56aecf4c0d209"} 11:25:12 INFO - Running post-run listener: copy_logs_to_upload_dir 11:25:12 INFO - Copying logs to upload dir... 11:25:12 INFO - mkdir: /builds/slave/test/build/upload/logs 11:25:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.687431 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-06 11:25:11.972657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 11:25:11.975926) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226 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/sha512/cb57a4b12301393badffd146e45390ff7f3ba2b509dc836dd75680366cac3cc1dc55dfd4eb73e2953c75f48ed27eff0b93b6c03f65d0be2430efb77239b96c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94563c2cbfae8221a240149f555f248d139d73f660bbfc9ef3ccf88d90078e4d56ee95946c180b27d7d9a279957330c12d53b1eaeff1e60d2ce56aecf4c0d209"} build_url:https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/L_vPGTU-TWCr0hsIsT_S_A/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/sha512/cb57a4b12301393badffd146e45390ff7f3ba2b509dc836dd75680366cac3cc1dc55dfd4eb73e2953c75f48ed27eff0b93b6c03f65d0be2430efb77239b96c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94563c2cbfae8221a240149f555f248d139d73f660bbfc9ef3ccf88d90078e4d56ee95946c180b27d7d9a279957330c12d53b1eaeff1e60d2ce56aecf4c0d209"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 11:25:12.000405) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:25:12.000716) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462557497.234934-1179080226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:25:12.082493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 11:25:12.082799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 11:25:12.083171) ========= ========= Total master_lag: 0.16 =========