builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1462835501.36 results: success (0) buildid: 20160509133020 builduid: fcce04ef59c241e58d3e355fa5a7795b revision: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.357689) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.358289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.358569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.385188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.385451) ========= 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=836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 16:11:41-- 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% 15.5M=0.001s 2016-05-09 16:11:41 (15.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137319 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.535530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.535878) ========= 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=836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017004 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.585595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:41.585974) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 --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=836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 16:11:41,925 truncating revision to first 12 chars 2016-05-09 16:11:41,926 Setting DEBUG logging. 2016-05-09 16:11:41,926 attempt 1/10 2016-05-09 16:11:41,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/648d9d0fd2f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 16:11:42,200 unpacking tar archive at: mozilla-inbound-648d9d0fd2f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:42.167486) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:42.167867) ========= script_repo_revision: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:42.168285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:42.168561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:42.177155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-09 16:11:42.177551) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:42 INFO - MultiFileLogger online at 20160509 16:11:42 in /builds/slave/test 16:11:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:11:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:42 INFO - {'append_to_log': False, 16:11:42 INFO - 'base_work_dir': '/builds/slave/test', 16:11:42 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:11:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:42 INFO - 'branch': 'Mozilla-Inbound', 16:11:42 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:42 INFO - 'config_files': ('talos/linux_config.py',), 16:11:42 INFO - 'default_actions': ('clobber', 16:11:42 INFO - 'read-buildbot-config', 16:11:42 INFO - 'download-and-extract', 16:11:42 INFO - 'populate-webroot', 16:11:42 INFO - 'create-virtualenv', 16:11:42 INFO - 'install', 16:11:42 INFO - 'run-tests'), 16:11:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:42 INFO - 'download_minidump_stackwalk': True, 16:11:42 INFO - 'download_symbols': 'ondemand', 16:11:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:42 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:42 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:42 INFO - 'installer_path': 'installer.exe', 16:11:42 INFO - 'log_level': 'info', 16:11:42 INFO - 'log_name': 'talos', 16:11:42 INFO - 'log_to_console': True, 16:11:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:42 INFO - 'opt_config_files': (), 16:11:42 INFO - 'pip_index': False, 16:11:42 INFO - 'sps_profile': False, 16:11:42 INFO - 'sps_profile_interval': 0, 16:11:42 INFO - 'suite': 'dromaeojs', 16:11:42 INFO - 'system_bits': '32', 16:11:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:42 INFO - 'title': 'talos-linux64-ix-028', 16:11:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:42 INFO - 'use_talos_json': True, 16:11:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:42 INFO - 'work_dir': 'build'} 16:11:42 INFO - ##### 16:11:42 INFO - ##### Running clobber step. 16:11:42 INFO - ##### 16:11:42 INFO - Running pre-action listener: _resource_record_pre_action 16:11:42 INFO - Running main action method: clobber 16:11:42 INFO - rmtree: /builds/slave/test/build 16:11:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:43 INFO - Running post-action listener: _resource_record_post_action 16:11:43 INFO - ##### 16:11:43 INFO - ##### Finished clobber step (success) 16:11:43 INFO - ##### 16:11:43 INFO - ##### 16:11:43 INFO - ##### Running read-buildbot-config step. 16:11:43 INFO - ##### 16:11:43 INFO - Running pre-action listener: _resource_record_pre_action 16:11:43 INFO - Running main action method: read_buildbot_config 16:11:43 INFO - Using buildbot properties: 16:11:43 INFO - { 16:11:43 INFO - "project": "", 16:11:43 INFO - "product": "firefox", 16:11:43 INFO - "script_repo_revision": "production", 16:11:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:11:43 INFO - "repository": "", 16:11:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:11:43 INFO - "buildid": "20160509133020", 16:11:43 INFO - "pgo_build": "True", 16:11:43 INFO - "basedir": "/builds/slave/test", 16:11:43 INFO - "buildnumber": 1797, 16:11:43 INFO - "slavename": "talos-linux64-ix-028", 16:11:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:11:43 INFO - "platform": "ubuntu64_hw", 16:11:43 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:11:43 INFO - "branch": "mozilla-inbound", 16:11:43 INFO - "repo_path": "integration/mozilla-inbound", 16:11:43 INFO - "revision": "648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4", 16:11:43 INFO - "stage_platform": "linux64-pgo", 16:11:43 INFO - "builduid": "fcce04ef59c241e58d3e355fa5a7795b", 16:11:43 INFO - "slavebuilddir": "test" 16:11:43 INFO - } 16:11:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:11:43 INFO - Running post-action listener: _resource_record_post_action 16:11:43 INFO - ##### 16:11:43 INFO - ##### Finished read-buildbot-config step (success) 16:11:43 INFO - ##### 16:11:43 INFO - ##### 16:11:43 INFO - ##### Running download-and-extract step. 16:11:43 INFO - ##### 16:11:43 INFO - Running pre-action listener: _resource_record_pre_action 16:11:43 INFO - Running main action method: download_and_extract 16:11:43 INFO - mkdir: /builds/slave/test/build/tests 16:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:43 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:44 INFO - Downloaded 1361 bytes. 16:11:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:44 INFO - Using the following test package requirements: 16:11:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:11:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:11:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'jsshell-linux-x86_64.zip'], 16:11:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:11:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:11:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:11:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:11:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:11:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:11: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')]} 16:11:44 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:50 INFO - Downloaded 23897515 bytes. 16:11:50 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'] 16:11:50 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 16:11:51 INFO - Return code: 0 16:11:51 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 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:51 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:57 INFO - Downloaded 23897515 bytes. 16:11:57 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'] 16:11:57 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 16:11:58 INFO - Return code: 0 16:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:58 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:59 INFO - Downloaded 10840152 bytes. 16:11:59 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'] 16:11:59 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 16:11:59 INFO - Return code: 0 16:11: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')]} 16:11:59 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:11:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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 16:12:01 INFO - Downloaded 58440120 bytes. 16:12:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:12:01 INFO - mkdir: /builds/slave/test/properties 16:12:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:01 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:01 INFO - Contents: 16:12:01 INFO - build_url:https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:12:01 INFO - Running post-action listener: _resource_record_post_action 16:12:01 INFO - Running post-action listener: set_extra_try_arguments 16:12:01 INFO - ##### 16:12:01 INFO - ##### Finished download-and-extract step (success) 16:12:01 INFO - ##### 16:12:01 INFO - ##### 16:12:01 INFO - ##### Running populate-webroot step. 16:12:01 INFO - ##### 16:12:01 INFO - Running pre-action listener: _resource_record_pre_action 16:12:01 INFO - Running main action method: populate_webroot 16:12:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:01 INFO - '--tppagecycles', 16:12:01 INFO - '7'], 16:12:01 INFO - 'tests': ['tsvgm']}}, 16:12:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['damp', 'tps']}, 16:12:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'tests': ['damp', 'tps']}, 16:12:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['dromaeo_dom']}, 16:12:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['a11yr', 16:12:01 INFO - 'ts_paint', 16:12:01 INFO - 'tpaint', 16:12:01 INFO - 'sessionrestore', 16:12:01 INFO - 'sessionrestore_no_auto_restore', 16:12:01 INFO - 'tabpaint']}, 16:12:01 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:01 INFO - 'ts_paint', 16:12:01 INFO - 'tpaint', 16:12:01 INFO - 'sessionrestore', 16:12:01 INFO - 'sessionrestore_no_auto_restore', 16:12:01 INFO - 'tabpaint']}, 16:12:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:12:01 INFO - 'ts_paint', 16:12:01 INFO - 'tpaint', 16:12:01 INFO - 'sessionrestore', 16:12:01 INFO - 'sessionrestore_no_auto_restore', 16:12:01 INFO - 'tabpaint']}, 16:12:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:12:01 INFO - 'ts_paint', 16:12:01 INFO - 'tpaint', 16:12:01 INFO - 'sessionrestore', 16:12:01 INFO - 'sessionrestore_no_auto_restore', 16:12:01 INFO - 'tabpaint']}, 16:12:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['a11yr', 16:12:01 INFO - 'ts_paint', 16:12:01 INFO - 'tpaint', 16:12:01 INFO - 'sessionrestore', 16:12:01 INFO - 'sessionrestore_no_auto_restore', 16:12:01 INFO - 'tabpaint']}, 16:12:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['a11yr', 16:12:01 INFO - 'ts_paint', 16:12:01 INFO - 'tpaint', 16:12:01 INFO - 'sessionrestore', 16:12:01 INFO - 'sessionrestore_no_auto_restore', 16:12:01 INFO - 'tabpaint']}, 16:12:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['tsvgx', 16:12:01 INFO - 'tsvgr_opacity', 16:12:01 INFO - 'tart', 16:12:01 INFO - 'tscrollx', 16:12:01 INFO - 'cart']}, 16:12:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:01 INFO - 'tsvgr_opacity', 16:12:01 INFO - 'tart', 16:12:01 INFO - 'tscrollx', 16:12:01 INFO - 'cart']}, 16:12:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'talos_options': ['--disable-e10s'], 16:12:01 INFO - 'tests': ['tp5o']}, 16:12:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'tests': ['tp5o']}, 16:12:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'talos_options': ['--disable-e10s', 16:12:01 INFO - '--xperf_path', 16:12:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:01 INFO - 'tests': ['tp5n']}, 16:12:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:01 INFO - 'talos_options': ['--xperf_path', 16:12:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:01 INFO - 'tests': ['tp5n']}}, 16:12:01 INFO - 'talos.zip': {'path': '', 16:12:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:01 INFO - Running post-action listener: _resource_record_post_action 16:12:01 INFO - ##### 16:12:01 INFO - ##### Finished populate-webroot step (success) 16:12:01 INFO - ##### 16:12:01 INFO - ##### 16:12:01 INFO - ##### Running create-virtualenv step. 16:12:01 INFO - ##### 16:12:01 INFO - Running pre-action listener: _resource_record_pre_action 16:12:01 INFO - Running main action method: create_virtualenv 16:12:01 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:12:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:01 INFO - Using real prefix '/usr' 16:12:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:04 INFO - Installing pip.................done. 16:12:04 INFO - Return code: 0 16:12:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:04 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:12:04 INFO - Using env: {'DISPLAY': ':0', 16:12:04 INFO - 'HOME': '/home/cltbld', 16:12:04 INFO - 'LANG': 'en_US.UTF-8', 16:12:04 INFO - 'LANGUAGE': 'en_US:en', 16:12:04 INFO - 'LOGNAME': 'cltbld', 16:12:04 INFO - 'MAIL': '/var/mail/cltbld', 16:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:04 INFO - 'MOZ_NO_REMOTE': '1', 16:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:04 INFO - 'NO_EM_RESTART': '1', 16:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:04 INFO - 'PWD': '/builds/slave/test', 16:12:04 INFO - 'SHELL': '/bin/bash', 16:12:04 INFO - 'SHLVL': '1', 16:12:04 INFO - 'TERM': 'linux', 16:12:04 INFO - 'TMOUT': '86400', 16:12:04 INFO - 'USER': 'cltbld', 16:12:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:04 INFO - '_': '/tools/buildbot/bin/python'} 16:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:12:04 INFO - Cleaning up... 16:12:04 INFO - Return code: 0 16:12:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:04 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:12:04 INFO - Using env: {'DISPLAY': ':0', 16:12:04 INFO - 'HOME': '/home/cltbld', 16:12:04 INFO - 'LANG': 'en_US.UTF-8', 16:12:04 INFO - 'LANGUAGE': 'en_US:en', 16:12:04 INFO - 'LOGNAME': 'cltbld', 16:12:04 INFO - 'MAIL': '/var/mail/cltbld', 16:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:04 INFO - 'MOZ_NO_REMOTE': '1', 16:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:04 INFO - 'NO_EM_RESTART': '1', 16:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:04 INFO - 'PWD': '/builds/slave/test', 16:12:04 INFO - 'SHELL': '/bin/bash', 16:12:04 INFO - 'SHLVL': '1', 16:12:04 INFO - 'TERM': 'linux', 16:12:04 INFO - 'TMOUT': '86400', 16:12:04 INFO - 'USER': 'cltbld', 16:12:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:04 INFO - '_': '/tools/buildbot/bin/python'} 16:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:04 INFO - Downloading/unpacking psutil>=0.7.1 16:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:06 INFO - Installing collected packages: psutil 16:12:06 INFO - Running setup.py install for psutil 16:12:06 INFO - building 'psutil._psutil_linux' extension 16:12:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:12:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:12:07 INFO - building 'psutil._psutil_posix' extension 16:12:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:12:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:12:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:07 INFO - Successfully installed psutil 16:12:07 INFO - Cleaning up... 16:12:07 INFO - Return code: 0 16:12:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:07 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:12:07 INFO - Using env: {'DISPLAY': ':0', 16:12:07 INFO - 'HOME': '/home/cltbld', 16:12:07 INFO - 'LANG': 'en_US.UTF-8', 16:12:07 INFO - 'LANGUAGE': 'en_US:en', 16:12:07 INFO - 'LOGNAME': 'cltbld', 16:12:07 INFO - 'MAIL': '/var/mail/cltbld', 16:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:07 INFO - 'MOZ_NO_REMOTE': '1', 16:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:07 INFO - 'NO_EM_RESTART': '1', 16:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:07 INFO - 'PWD': '/builds/slave/test', 16:12:07 INFO - 'SHELL': '/bin/bash', 16:12:07 INFO - 'SHLVL': '1', 16:12:07 INFO - 'TERM': 'linux', 16:12:07 INFO - 'TMOUT': '86400', 16:12:07 INFO - 'USER': 'cltbld', 16:12:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:07 INFO - '_': '/tools/buildbot/bin/python'} 16:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:12:09 INFO - Installing collected packages: mozsystemmonitor 16:12:09 INFO - Running setup.py install for mozsystemmonitor 16:12:09 INFO - Successfully installed mozsystemmonitor 16:12:09 INFO - Cleaning up... 16:12:09 INFO - Return code: 0 16:12:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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', '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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:12: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 blobuploader==1.2.4 16:12:09 INFO - Using env: {'DISPLAY': ':0', 16:12:09 INFO - 'HOME': '/home/cltbld', 16:12:09 INFO - 'LANG': 'en_US.UTF-8', 16:12:09 INFO - 'LANGUAGE': 'en_US:en', 16:12:09 INFO - 'LOGNAME': 'cltbld', 16:12:09 INFO - 'MAIL': '/var/mail/cltbld', 16:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:09 INFO - 'MOZ_NO_REMOTE': '1', 16:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:09 INFO - 'NO_EM_RESTART': '1', 16:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:09 INFO - 'PWD': '/builds/slave/test', 16:12:09 INFO - 'SHELL': '/bin/bash', 16:12:09 INFO - 'SHLVL': '1', 16:12:09 INFO - 'TERM': 'linux', 16:12:09 INFO - 'TMOUT': '86400', 16:12:09 INFO - 'USER': 'cltbld', 16:12:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:09 INFO - '_': '/tools/buildbot/bin/python'} 16:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:12 INFO - Downloading docopt-0.6.1.tar.gz 16:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:12 INFO - Running setup.py install for blobuploader 16:12:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:12 INFO - Running setup.py install for requests 16:12:13 INFO - Running setup.py install for docopt 16:12:13 INFO - Successfully installed blobuploader requests docopt 16:12:13 INFO - Cleaning up... 16:12:13 INFO - Return code: 0 16:12:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:13 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:13 INFO - Using env: {'DISPLAY': ':0', 16:12:13 INFO - 'HOME': '/home/cltbld', 16:12:13 INFO - 'LANG': 'en_US.UTF-8', 16:12:13 INFO - 'LANGUAGE': 'en_US:en', 16:12:13 INFO - 'LOGNAME': 'cltbld', 16:12:13 INFO - 'MAIL': '/var/mail/cltbld', 16:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:13 INFO - 'MOZ_NO_REMOTE': '1', 16:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:13 INFO - 'NO_EM_RESTART': '1', 16:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:13 INFO - 'PWD': '/builds/slave/test', 16:12:13 INFO - 'SHELL': '/bin/bash', 16:12:13 INFO - 'SHLVL': '1', 16:12:13 INFO - 'TERM': 'linux', 16:12:13 INFO - 'TMOUT': '86400', 16:12:13 INFO - 'USER': 'cltbld', 16:12:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:13 INFO - '_': '/tools/buildbot/bin/python'} 16:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:13 INFO - Running setup.py (path:/tmp/pip-kPLfN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:13 INFO - Running setup.py (path:/tmp/pip-da3k6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:13 INFO - Running setup.py (path:/tmp/pip-3QY2Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:13 INFO - Running setup.py (path:/tmp/pip-cMBgao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:13 INFO - Running setup.py (path:/tmp/pip-rPgq7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:13 INFO - Running setup.py (path:/tmp/pip-bvRrs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:13 INFO - Running setup.py (path:/tmp/pip-bfAFFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:13 INFO - Running setup.py (path:/tmp/pip-CNWca4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:14 INFO - Running setup.py (path:/tmp/pip-JYcmel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:14 INFO - Running setup.py (path:/tmp/pip-RAGxDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:14 INFO - Running setup.py (path:/tmp/pip-6ANl9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:14 INFO - Running setup.py (path:/tmp/pip-JjgNac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:14 INFO - Running setup.py (path:/tmp/pip-vzg3Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:14 INFO - Running setup.py (path:/tmp/pip-1orxC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:14 INFO - Running setup.py (path:/tmp/pip-u_sZXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:14 INFO - Running setup.py (path:/tmp/pip-ss21GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:14 INFO - Running setup.py (path:/tmp/pip-KGfr5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:14 INFO - Running setup.py install for manifestparser 16:12:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:14 INFO - Running setup.py install for mozcrash 16:12:14 INFO - Running setup.py install for mozdebug 16:12:14 INFO - Running setup.py install for mozdevice 16:12:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Running setup.py install for mozfile 16:12:15 INFO - Running setup.py install for mozhttpd 16:12:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Running setup.py install for mozinfo 16:12:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Running setup.py install for mozInstall 16:12:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Running setup.py install for mozleak 16:12:15 INFO - Running setup.py install for mozlog 16:12:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Running setup.py install for moznetwork 16:12:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Running setup.py install for mozprocess 16:12:15 INFO - Running setup.py install for mozprofile 16:12:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for mozrunner 16:12:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for mozscreenshot 16:12:16 INFO - Running setup.py install for moztest 16:12:16 INFO - Running setup.py install for mozversion 16:12:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:16 INFO - Cleaning up... 16:12:16 INFO - Return code: 0 16:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:16 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:16 INFO - Using env: {'DISPLAY': ':0', 16:12:16 INFO - 'HOME': '/home/cltbld', 16:12:16 INFO - 'LANG': 'en_US.UTF-8', 16:12:16 INFO - 'LANGUAGE': 'en_US:en', 16:12:16 INFO - 'LOGNAME': 'cltbld', 16:12:16 INFO - 'MAIL': '/var/mail/cltbld', 16:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:16 INFO - 'MOZ_NO_REMOTE': '1', 16:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:16 INFO - 'NO_EM_RESTART': '1', 16:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:16 INFO - 'PWD': '/builds/slave/test', 16:12:16 INFO - 'SHELL': '/bin/bash', 16:12:16 INFO - 'SHLVL': '1', 16:12:16 INFO - 'TERM': 'linux', 16:12:16 INFO - 'TMOUT': '86400', 16:12:16 INFO - 'USER': 'cltbld', 16:12:16 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:16 INFO - '_': '/tools/buildbot/bin/python'} 16:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:16 INFO - Running setup.py (path:/tmp/pip-SRDTUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:16 INFO - Running setup.py (path:/tmp/pip-1j1wPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:16 INFO - Running setup.py (path:/tmp/pip-Lf7Qzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:16 INFO - Running setup.py (path:/tmp/pip-OAx4Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:17 INFO - Running setup.py (path:/tmp/pip-vd7kNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:17 INFO - Running setup.py (path:/tmp/pip-skvP8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:17 INFO - Running setup.py (path:/tmp/pip-bRKstX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:17 INFO - Running setup.py (path:/tmp/pip-cOy5Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:17 INFO - Running setup.py (path:/tmp/pip-daaIwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:17 INFO - Running setup.py (path:/tmp/pip-j6oiOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:17 INFO - Running setup.py (path:/tmp/pip-vxsFH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:17 INFO - Running setup.py (path:/tmp/pip-JpoExs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:17 INFO - Running setup.py (path:/tmp/pip-Qxlimh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:17 INFO - Running setup.py (path:/tmp/pip-bMEl_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:17 INFO - Running setup.py (path:/tmp/pip-ZXXclM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:17 INFO - Running setup.py (path:/tmp/pip-dxThhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:17 INFO - Running setup.py (path:/tmp/pip-HGqutK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:19 INFO - Downloading blessings-1.6.tar.gz 16:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:19 INFO - Installing collected packages: blessings 16:12:19 INFO - Running setup.py install for blessings 16:12:19 INFO - Successfully installed blessings 16:12:19 INFO - Cleaning up... 16:12:20 INFO - Return code: 0 16:12:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:20 INFO - Reading from file tmpfile_stdout 16:12:20 INFO - Current package versions: 16:12:20 INFO - argparse == 1.2.1 16:12:20 INFO - blessings == 1.6 16:12:20 INFO - blobuploader == 1.2.4 16:12:20 INFO - docopt == 0.6.1 16:12:20 INFO - manifestparser == 1.1 16:12:20 INFO - mozInstall == 1.12 16:12:20 INFO - mozcrash == 0.17 16:12:20 INFO - mozdebug == 0.1 16:12:20 INFO - mozdevice == 0.48 16:12:20 INFO - mozfile == 1.2 16:12:20 INFO - mozhttpd == 0.7 16:12:20 INFO - mozinfo == 0.9 16:12:20 INFO - mozleak == 0.1 16:12:20 INFO - mozlog == 3.1 16:12:20 INFO - moznetwork == 0.27 16:12:20 INFO - mozprocess == 0.22 16:12:20 INFO - mozprofile == 0.28 16:12:20 INFO - mozrunner == 6.11 16:12:20 INFO - mozscreenshot == 0.1 16:12:20 INFO - mozsystemmonitor == 0.0 16:12:20 INFO - moztest == 0.7 16:12:20 INFO - mozversion == 1.4 16:12:20 INFO - psutil == 3.1.1 16:12:20 INFO - requests == 1.2.3 16:12:20 INFO - wsgiref == 0.1.2 16:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:20 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:20 INFO - Using env: {'DISPLAY': ':0', 16:12:20 INFO - 'HOME': '/home/cltbld', 16:12:20 INFO - 'LANG': 'en_US.UTF-8', 16:12:20 INFO - 'LANGUAGE': 'en_US:en', 16:12:20 INFO - 'LOGNAME': 'cltbld', 16:12:20 INFO - 'MAIL': '/var/mail/cltbld', 16:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:20 INFO - 'MOZ_NO_REMOTE': '1', 16:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:20 INFO - 'NO_EM_RESTART': '1', 16:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:20 INFO - 'PWD': '/builds/slave/test', 16:12:20 INFO - 'SHELL': '/bin/bash', 16:12:20 INFO - 'SHLVL': '1', 16:12:20 INFO - 'TERM': 'linux', 16:12:20 INFO - 'TMOUT': '86400', 16:12:20 INFO - 'USER': 'cltbld', 16:12:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:20 INFO - '_': '/tools/buildbot/bin/python'} 16:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:20 INFO - Cleaning up... 16:12:20 INFO - Return code: 0 16:12:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:20 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:12:20 INFO - Using env: {'DISPLAY': ':0', 16:12:20 INFO - 'HOME': '/home/cltbld', 16:12:20 INFO - 'LANG': 'en_US.UTF-8', 16:12:20 INFO - 'LANGUAGE': 'en_US:en', 16:12:20 INFO - 'LOGNAME': 'cltbld', 16:12:20 INFO - 'MAIL': '/var/mail/cltbld', 16:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:20 INFO - 'MOZ_NO_REMOTE': '1', 16:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:20 INFO - 'NO_EM_RESTART': '1', 16:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:20 INFO - 'PWD': '/builds/slave/test', 16:12:20 INFO - 'SHELL': '/bin/bash', 16:12:20 INFO - 'SHLVL': '1', 16:12:20 INFO - 'TERM': 'linux', 16:12:20 INFO - 'TMOUT': '86400', 16:12:20 INFO - 'USER': 'cltbld', 16:12:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:20 INFO - '_': '/tools/buildbot/bin/python'} 16:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:20 INFO - Downloading/unpacking jsonschema 16:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:22 INFO - Downloading/unpacking functools32 (from jsonschema) 16:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:22 INFO - warning: no files found matching '*.txt' 16:12:22 INFO - no previously-included directories found matching 'build' 16:12:22 INFO - no previously-included directories found matching 'dist' 16:12:22 INFO - no previously-included directories found matching '.git*' 16:12:22 INFO - Installing collected packages: jsonschema, functools32 16:12:22 INFO - Running setup.py install for functools32 16:12:22 INFO - warning: no files found matching '*.txt' 16:12:22 INFO - no previously-included directories found matching 'build' 16:12:22 INFO - no previously-included directories found matching 'dist' 16:12:22 INFO - no previously-included directories found matching '.git*' 16:12:22 INFO - Successfully installed jsonschema functools32 16:12:22 INFO - Cleaning up... 16:12:23 INFO - Return code: 0 16:12:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:23 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 0x7f84bd3d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, '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': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:12:23 INFO - Using env: {'DISPLAY': ':0', 16:12:23 INFO - 'HOME': '/home/cltbld', 16:12:23 INFO - 'LANG': 'en_US.UTF-8', 16:12:23 INFO - 'LANGUAGE': 'en_US:en', 16:12:23 INFO - 'LOGNAME': 'cltbld', 16:12:23 INFO - 'MAIL': '/var/mail/cltbld', 16:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:23 INFO - 'MOZ_NO_REMOTE': '1', 16:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:23 INFO - 'NO_EM_RESTART': '1', 16:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:23 INFO - 'PWD': '/builds/slave/test', 16:12:23 INFO - 'SHELL': '/bin/bash', 16:12:23 INFO - 'SHLVL': '1', 16:12:23 INFO - 'TERM': 'linux', 16:12:23 INFO - 'TMOUT': '86400', 16:12:23 INFO - 'USER': 'cltbld', 16:12:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:23 INFO - '_': '/tools/buildbot/bin/python'} 16:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:23 INFO - Downloading/unpacking flake8 16:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:12:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:12:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:25 INFO - no previously-included directories found matching 'docs/_build' 16:12:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:12:25 INFO - Running setup.py install for pep8 16:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:25 INFO - no previously-included directories found matching 'docs/_build' 16:12:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:12:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:12:26 INFO - Cleaning up... 16:12:26 INFO - Return code: 0 16:12:26 INFO - Running post-action listener: _resource_record_post_action 16:12:26 INFO - Running post-action listener: _start_resource_monitoring 16:12:26 INFO - Starting resource monitoring. 16:12:26 INFO - ##### 16:12:26 INFO - ##### Finished create-virtualenv step (success) 16:12:26 INFO - ##### 16:12:26 INFO - ##### 16:12:26 INFO - ##### Running install step. 16:12:26 INFO - ##### 16:12:26 INFO - Running pre-action listener: _resource_record_pre_action 16:12:26 INFO - Running main action method: install 16:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:26 INFO - Reading from file tmpfile_stdout 16:12:26 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:26 INFO - Reading from file tmpfile_stdout 16:12:26 INFO - Output received: 16:12:26 INFO - Usage: mozinstall [options] installer 16:12:26 INFO - Options: 16:12:26 INFO - -h, --help show this help message and exit 16:12:26 INFO - -d DEST, --destination=DEST 16:12:26 INFO - Directory to install application into. [default: 16:12:26 INFO - "/builds/slave/test"] 16:12:26 INFO - --app=APP Application being installed. [default: firefox] 16:12:26 INFO - mkdir: /builds/slave/test/build/application 16:12:26 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'] 16:12:26 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 16:12:43 INFO - Reading from file tmpfile_stdout 16:12:43 INFO - Output received: 16:12:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:43 INFO - Running post-action listener: _resource_record_post_action 16:12:43 INFO - ##### 16:12:43 INFO - ##### Finished install step (success) 16:12:43 INFO - ##### 16:12:43 INFO - ##### 16:12:43 INFO - ##### Running run-tests step. 16:12:43 INFO - ##### 16:12:43 INFO - Running pre-action listener: _resource_record_pre_action 16:12:43 INFO - Running main action method: run_tests 16:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:43 INFO - Python 2.7.3 16:12:43 INFO - Return code: 0 16:12:43 INFO - grabbing minidump binary from tooltool 16:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:43 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 0x10d69c0>, '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 0x10d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:12:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:12:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:43 INFO - Return code: 0 16:12:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:12:44 INFO - Return code: 0 16:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 16:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 16:12:44 INFO - Using env: {'DISPLAY': ':0', 16:12:44 INFO - 'HOME': '/home/cltbld', 16:12:44 INFO - 'LANG': 'en_US.UTF-8', 16:12:44 INFO - 'LANGUAGE': 'en_US:en', 16:12:44 INFO - 'LOGNAME': 'cltbld', 16:12:44 INFO - 'MAIL': '/var/mail/cltbld', 16:12:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:44 INFO - 'MOZ_NO_REMOTE': '1', 16:12:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:44 INFO - 'NO_EM_RESTART': '1', 16:12:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:44 INFO - 'PWD': '/builds/slave/test', 16:12:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:44 INFO - 'SHELL': '/bin/bash', 16:12:44 INFO - 'SHLVL': '1', 16:12:44 INFO - 'TERM': 'linux', 16:12:44 INFO - 'TMOUT': '86400', 16:12:44 INFO - 'USER': 'cltbld', 16:12:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920', 16:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:44 INFO - '_': '/tools/buildbot/bin/python'} 16:12:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 16:12:44 INFO - mozversion application_buildid: 20160509133020 16:12:44 INFO - mozversion application_changeset: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 16:12:44 INFO - mozversion application_display_name: Nightly 16:12:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:44 INFO - mozversion application_name: Firefox 16:12:44 INFO - mozversion application_remotingname: firefox 16:12:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:12:44 INFO - mozversion application_vendor: Mozilla 16:12:44 INFO - mozversion application_version: 49.0a1 16:12:44 INFO - mozversion platform_buildid: 20160509133020 16:12:44 INFO - mozversion platform_changeset: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 16:12:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:12:44 INFO - mozversion platform_version: 49.0a1 16:12:44 INFO - using testdate: 1462835564 16:12:44 INFO - actual date: 1462835564 16:12:44 INFO - starting webserver on 'localhost:54801' 16:12:44 INFO - SUITE-START | Running 2 tests 16:12:44 INFO - TEST-START | dromaeo_css 16:12:44 INFO - operating with platform_type : linux_ 16:12:44 INFO - Initialising browser for dromaeo_css test... 16:12:44 INFO - TEST-INFO | started process 24560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprbDpUz/profile http://localhost:54801/getInfo.html) 16:12:48 INFO - PROCESS | 24560 | __metrics Screen width/height:1600/1200 16:12:48 INFO - PROCESS | 24560 | colorDepth:24 16:12:48 INFO - PROCESS | 24560 | Browser inner width/height: 1024/697 16:12:48 INFO - PROCESS | 24560 | __metrics 16:12:49 ERROR - PROCESS | 24560 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:12:50 INFO - TEST-INFO | 24560: exit 0 16:12:50 INFO - Browser initialized. 16:12:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:50 INFO - TEST-INFO | started process 24644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprbDpUz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:02 INFO - PROCESS | 24644 | RSS: Main: 152301568 16:13:02 INFO - PROCESS | 24644 | 16:13:52 INFO - PROCESS | 24644 | 1462835632919 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:16:00 INFO - PROCESS | 24644 | Cycle 1(1): loaded http://localhost:54801/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54801/tests/dromaeo/cssquery-ext.html) 16:16:01 INFO - PROCESS | 24644 | RSS: Main: 260689920 16:16:01 INFO - PROCESS | 24644 | 16:19:04 INFO - PROCESS | 24644 | Cycle 1(1): loaded http://localhost:54801/tests/dromaeo/cssquery-ext.html (next: http://localhost:54801/tests/dromaeo/cssquery-jquery.html) 16:19:04 INFO - PROCESS | 24644 | RSS: Main: 235642880 16:19:04 INFO - PROCESS | 24644 | 16:22:06 INFO - PROCESS | 24644 | Cycle 1(1): loaded http://localhost:54801/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54801/tests/dromaeo/cssquery-mootools.html) 16:22:07 INFO - PROCESS | 24644 | RSS: Main: 238075904 16:22:07 INFO - PROCESS | 24644 | 16:25:09 INFO - PROCESS | 24644 | Cycle 1(1): loaded http://localhost:54801/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54801/tests/dromaeo/cssquery-prototype.html) 16:25:09 INFO - PROCESS | 24644 | RSS: Main: 233365504 16:25:09 INFO - PROCESS | 24644 | 16:28:12 INFO - PROCESS | 24644 | Cycle 1(1): loaded http://localhost:54801/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54801/tests/dromaeo/cssquery-yui.html) 16:28:13 INFO - PROCESS | 24644 | RSS: Main: 216920064 16:28:13 INFO - PROCESS | 24644 | 16:31:15 INFO - PROCESS | 24644 | Cycle 1(1): loaded http://localhost:54801/tests/dromaeo/cssquery-yui.html (next: http://localhost:54801/tests/dromaeo/cssquery-dojo.html) 16:31:16 INFO - PROCESS | 24644 | RSS: Main: 277815296 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | __start_tp_report 16:31:16 INFO - PROCESS | 24644 | _x_x_mozilla_page_load 16:31:16 INFO - PROCESS | 24644 | _x_x_mozilla_page_load_details 16:31:16 INFO - PROCESS | 24644 | |i|pagename|runs| 16:31:16 INFO - PROCESS | 24644 | |0;dojo.html;3160.5891234139567;3171.0962375722925;3189.776715629906;3212.8232947187894;3229.1927018245437;5308.787648494065;5318.149096144618;5404.351477822662;5501.229827824103;5536.944630553693;5275.419703832585;5336.039512887679;5341.919871201935;5342.813001544937;5369.221462887888;4807.61539076873;4827.63792715546;4979.427365852937;5019.096562618727;5026.472220416858;4821.4696383397795;4970.925436118461;4988.925166122511;5007.524285192919;5040.067587496325;4801.783919723621;4808.903821923559;4848.563629273364;4857.878553036167;4860.562549370538;4849.612031037508;4853.975730121362;4862.854114376574;4869.586085182764;4896.779644915988;4774.355462012619;4787.090452813989;4792.2332426811545;4803.471618122038;4859.927101093486;5325.7869685212545;5332.546733527654;5338.652987555796;5368.70472124033;5383.946160538384;5718.857028574277;5720.056190728525;5728.22668939692;5773.566982476331;5779.595428320019;5700.37295897451;5803.680797556132;5803.767849286023;5812.680302583356;5846.269216347957;5472.343318801769;5510.6969116698565;5522.861928451821;5526.613137080406;5530.834074977757;6017.669028203403;6022.849428764228;6032.547558933097;6033.064874944391;6034.2155519782145;5517.531009864127;5632.098864181711;5654.971725141348;5697.116946873241;5723.914141287884;5793.826185214451;5793.913091303634;5796.043652797325;5798.536117110621;5799.594028417971;5479.123340265618;5771.68255745938;5783.334916484658;5783.797567085132;5792;5763.567732420085;5806.79676211339;5835.095560188178;5850.414958504116;5855.531557475391;4387.517373088957;4425.114977004612;4429.623482004002;4431.800568974404;4468.888277793081;3869.1487872667967;3872.7676339419727;3971.702122340836;3998.960010399917;4009.919801603952;5388.595855310789;5396.91904621431;5418.4039755626845;5432.293801805819;5455.208994695826;5794.072948328248;5796.21751063601;5797.768089276382;5802.129680547867;5809.186713860063;5345.786168553214;5442.564594832404;5449.291592093082;5449.618526703172;5450.700211488406;4984.252362145708;5014.0974624567925;5017.122003649347;5018;5054.620903432257;6003.399660034049;6008.098785182257;6009.278886533644;6012.458878700938;6018.127371531104;5604.215409842707;5733.942660573341;5822.475977162076;5853.151293062568;5855.092460668603;5982.49148822355;6008.669523176267;6013.098035294741;6014.36849130835;6045.395460453919;5667.263255776723;5673.914891276551;5704.971475142598;5710.914336284876;5722.341930678025;5666.603337766317;5722.427757224411;5778.046622307273;5790.7973220937065;5846.707664616837;5659.377468478382;5669.036263835241;5669.688167150846;5673.886522269614;5687.488126068673;5644.3508996465935;5661.575381846295;5666.716664166857;5671.517920976598;5674.517665998436;5420.864478388072;5553.222548843084;5622.437756224508;5634.154876768517;5672.801451949327;5785.247917770663;5807.332156802022;5846.327672317568;5848.736806843617;5856.560757943086;5442.102053161184;5645.350784659817;5692.886142277049;5697.943020569741;5742.138679197987 16:31:16 INFO - PROCESS | 24644 | |1;ext.html;599.9040153575429;641.8202903187108;642.5983760149907;652.367203812302;660.112149159381;42010.57989420105;43564.564354356444;43625.345619815685;43723.90690232742;45735;43277;43705;43780.3432948506;43812.561874381245;43827.78086109573;8710.128987101303;8890.688825891095;8901.376903616749;8902.688405905794;8904.821903561957;8771.07903670115;8842.690505832297;8847.95576022119;8854;8856.911430885706;8877.33419993503;8893.199612034916;8901.287896968259;8910.732678019669;8915.153060459246;8809.867851982193;8849.380543361967;8851.690190843321;8851.822963540757;8854.513001784899;8709.259712924346;8783.824323513494;8784.12158784123;8791.164839340252;8791.824163516758;40078.79960600178;40381.79809100965;40409.59590404088;40494.392584111265;40520.392194117114;3630.3283892479976;3653.4702468142236;3664.5052917856015;3901.590333015021;4274.5939135782055;30089.548656770166;32303.676963230537;32736.181595460064;32762.6723732762;33891.491627625604;4282.229198744225;4344.565543445662;4369.978150109261;4502.842400515966;4568.337591049312;309116;314447;314702.42648786836;315310;316091;34920.82539587286;35602.465963010574;35773.46339804905;35789.64210357915;61648.69175654093;37300.81349593234;37454.81272593619;37488.25023499569;37513.43729844054;37703;14465;14655.34050967709;14656.193909335088;14683.853161468249;14683.926580367244;12086.818697719542;12204.938975305067;12233.388330583435;12246.326452045223;12416.875831241752;8665.740027799176;8694.739157825275;8719.215270625675;8745.868811967826;8812.60343284541;3413.573303337083;3436.879709210166;3460.1176699941857;3471.3230919970365;3512.121969507623;1022.1311884897777;1108.733903863067;1117.932924024561;1174.0196935558733;1234.8332975048434;31375;31896.521552176735;32376.705769691296;32619.347613047605;33118.834405827816;1094.813881640123;1125.9493322800495;1144.4678224625422;1148.8621365436202;1224.865264820869;17055.232514536874;17113.572160696083;17174.39889603858;17188;17533.473995779892;578083;591054;592106;869488;869814;55793;56905.14642280369;56917.43082569121;57009.714951424976;57019.144712829344;1390.2770559309104;1409.7532931736905;1425.49394964786;1434.4262295081842;1445.768677011694;30502.694973049984;32639.510407343434;32650.673493264763;32722;32945.67054329522;47328;47758.32845850517;47786.76106619445;47806.521934780205;47847.52152478431;403314;407088;407602;407897;408577;27549.658279046507;28779;29004.27489312784;29026.274343140747;29070.56394154047;45994.77002614966;51067.642227862336;51637.22544161916;52508;52531;39405;39979.00052498711;40383.59616403798;40553;41148.38277425901;40383.39424908687;40694.79652601718;40936.18127637371;40993.385099224135;41131;33414.66585334213;41947.790261048496;42757.78621106874;43174.78412607917;45815.54184458246;34741.65258347485;36154.8192259037;36282.27435451329;36365.81817090898;36601.63398365982;28410.289742756595;28761.712382875903;28834;28864.2783930395;29450.263743406587 16:31:16 INFO - PROCESS | 24644 | |2;jquery.html;394.72763792982823;401.444000059917;406.74171900842975;408.3955745496663;424.09032625019336;13051.404998264832;17632.11839408029;19313.71029434558;19334;19721.112549935253;14787.630309242275;16365.672686546292;17185;17515.73726394105;18324.81675183251;5523.99999999999;5667.546596272309;5704.54363650909;5713.028785106542;5718.228039214694;5644.379118296984;5668.263125793641;5683.886322273552;5688.203651488774;5718.628289161212;4069.308217603015;4246.7027308088445;5960.1953736245705;6266.342034086424;6270.216222972129;6129.509639228851;6286.528510361742;6341.112244285804;6341.778037768679;6352.9364706353035;5427.131658934591;5484;5495.945040549584;5550.111982082847;5552.416996215379;22005.22981695649;22046.228382006713;22423.55152896933;22870.656940145913;23037.424064398358;2607.634931109646;2656.296081538394;2663.8002149838644;2664.067576348282;3026.636803583584;13961.371738271802;14332.211728354936;14376.856231437761;14428.350724217435;14802.40790368384;1969.901504924748;2009.4875806669206;2012;2028.5739994601151;2062.4740691123666;69466.30533694649;72757.63621181913;73928.63035684841;84564;84830;10142.44216568081;10681.786364272672;10894.128469722404;10966.287191332538;11032.227744058;15726.449574264845;15808.130552819704;15819.604509887346;15827.366905323888;15833.445829395916;7625.23747625233;7932.682692692343;7993.640286187136;8043.195680432027;8081.545321842125;7504.924950750532;7524.435667324863;7588.430867684946;7709.113451953097;7754.728584499516;4378.562143785596;4494.483134439516;4748.762561871962;4867.659263851568;4902.558769710743;1882.9717554236697;1889.1782074797507;1921.903904804782;1987.7415935928236;1998.600279944017;452.38249789037724;476.28794951547656;936.8922573903952;1040.15747244732;1140.912130800633;10985.176111791647;11385.14611404148;11620.418979051183;11715.1799374043;11737;458.5483298950531;465.05361589166563;467.93448917151625;470.7410923991859;481.7206020508097;5945.316288626776;6159.384061593805;6173.722182501798;6221.4089661482085;6254.343293954069;485071;495526;502885;506837;531330;55702.16446753302;74984;88456;90145.09854901498;94523;997.3218211616025;1018.6842078955548;1028.082625902686;1032.3031953431405;1099.1042300525207;17268.654626907643;17276.352935904742;17280.567985800455;17373;17597.560060998065;34866.47700284549;35328.29343413066;36017.819910900274;38135.42796858105;41787.582124179586;42816.78591607022;53014;53122.468775311754;53128;53241;8193.303569196685;8225.71210007647;8587.914120858712;8653.95673021656;8726.563671816511;11600.709982250173;12958.740825183631;13099.738005240033;13151.342432878126;13195.67010824737;6408.455281300955;7745.419093568117;11560.30638161713;11606.361650109326;11619.302841829518;8397.70608028716;11212.607558735404;11462.426878655868;11561.30632162073;11758;11604.361760102938;11665.88334116648;11819.763604728028;11898.405079746151;11901.166918315635;8325.916740832514;8447.197516235949;8513.87229191575;8898.510581918057;8989.325800564853;10253.84619230727;11739;11799.941000294944;11880.762384752084;12012.459439325427 16:31:16 INFO - PROCESS | 24644 | |3;mootools.html;1319.9208047517143;1550.5348395481356;1553.9766903496445;1740.895546267224;1860.5255659806746;8445.11326310737;8704.738857834267;8767;9001.50491722955;9002.099790020995;8769.824603507943;8941.687040953568;8943;8964;8981.730548083551;1970.4679736471144;2040.816326530612;2043.4278402047375;2269.1944359752256;2300.907963681451;2242.8317876159354;2332.125452955142;2332.5218330242346;2349.4126468382906;2354.117206047732;2240.5630901974123;2253.752087270399;2256.717910261217;2264.5810525052834;2317.4669825940045;1962.7154062660834;2196.901139448729;2265.8980345884393;2300.4478925058033;2303.7120359955006;2258.3563684349883;2294.66727324537;2297.609406400899;2297.689811875409;2298.9310320690406;8656.8701469478;8666.6100025499;8689.3048556116;8708.912910870873;8710.085441028728;4997.175466048097;5128.1794912813775;5137.61467889906;5160.25176349431;5169.4572069932865;3130.2174456385906;3234.0782876879975;3345.063382252973;3417.3848707232687;3424.7088997435;998.4009594243469;1006.9446180460071;2130.222468798893;2183.3886511776727;2185.497335612802;12143.757124857542;12368.381580920917;12472.376381180904;12654.81017784734;13013.739725205538;4324.654027677778;4326.58897404746;4385.166818304576;4436.977815110904;4455.420795296591;9238.630454781733;9258.629654813732;9265.861012084824;9278.443293402417;9305.441673499612;4867.148249056401;4871.0014447038275;4905.068037072945;4909.435414927258;4917.7786999585105;4307.418498502725;4471.083427897273;4532.5694059064335;4579.771011449414;4603.332516785114;3766.7928263945196;3772.5284339457567;3829.483019792348;3854.4603755474254;3877.1470276539117;1088.5101704233127;1108.9944550277196;1109.1293334732197;1116.6147679050714;1117.8267368557886;989.8713167288206;992.7666998255404;993.1707024634367;1005.0602686488157;1005.4520286443759;6081.726322315506;6114.724837382329;6175.752969881154;6257.624542527463;6273.027680709497;432.1335721877615;433.1272485940832;433.46683579197764;436.61141583990275;438.6030642268688;4156.189543039139;4189.581041895786;4218.156368726206;4237.788110594458;4240;11232.66302010941;11711.531538738525;11776.057915366922;11788.646340609796;11803.586874459354;11652.94173529127;11657.533698652129;11749.530018799323;11751.647450576496;11757.059435245159;8172;8390.706325278465;8617.48295102296;8683.478991260545;8708.956455217683;6100.267967843887;6124.601900876429;6142.262928448615;6192.628442293477;6246.937530624818;10447.84328235062;10484.580616775243;10730.678079657622;10737.302075365076;10858.13134949218;10551.577936882439;10670.89329106699;10733;10741.570337186426;10961.83557246626;7101.2898710128575;7686.961565192362;7884.329831964347;7989.2809647132035;8113.594320283844;8884.378093533649;8898.02121766618;8952.910470895467;8986.910130898606;8991.910080899108;7724.652390642547;7751.728689495841;7796.259355361231;8027.5584842834205;8069.909492175365;7592.620368981418;7713.575753333621;7751.728689495841;7796.883046754417;7857.214278572097;7086;7139.071920650283;7149.392301654418;7154.284571542804;7161.856762864818;4888.291197776373;4944.258361245842;5057.5448209659835;5153.896922061613;5189.247559103985;5354.982553314858;5392.137258038695;5406.864828379322;5411.350637923474;5456.727163641882 16:31:16 INFO - PROCESS | 24644 | |4;prototype.html;317.0504339503188;319.16697419734487;324.30598519168973;327.68869573904794;328.3629758268958;5367.570594352447;5403.324584426947;5445.891082178359;5454.427285135058;5473.480019398151;5353.732313384335;5361.222622719703;5367.765413954793;5368.46315368463;5375.489328513795;3938.369860822276;4036.636702696757;4188.706790524665;4193.832246710128;4197.664186865043;4133.586641335857;4142.8135733891895;4158.355454904495;4167.166566686659;4184.832606695729;3898.6491215790575;4107.938380924274;4111.958880411203;4126.484189476316;4144.109016561454;4018.618231268025;4117.938230926538;4118.814653340592;4132.483439570054;4135.676583493283;3621.9275614487824;3650;3659.670629643345;3660.194757153422;3678.657290089125;5156.613254005964;5174.818881339135;5178.818741344073;5203.739813009334;5208.713520756357;4474.865754027384;4691.249400096002;4692.929606055878;4738.265568836836;4740.762961851894;5616.241807356037;5656.151577263402;5657.2928383952;5672.489475947144;5697.31632204134;3893.1824316893485;3930.9213815723524;3961.841526338943;3986.54154772202;3988.74073185242;5608.270924779793;5763.596548241625;5804.825855224308;5828.388019258002;5832.825015249507;3953.6046395360236;3974.105826189142;3977.2244412339896;3978.1446988896946;3980.5621381647998;4053.5338436079637;4062.532808727034;4075.714699971033;4077.062275676611;4078.1232035112;4586.541345865454;4625.606823419979;4668.4631267404;4692.592222333286;4735.12400205963;5574.414686457863;5583.74873130702;5586.469285417878;5587.161925711176;5609.49514543693;1402.8036074949516;1406.528812847687;1416.7886457079255;1420.453125546672;1423.224342733192;878.0780180810124;881.6870011146079;892.8526793079199;900.8513595256841;937;5275.709835959059;5326.840194794162;5366.436524164985;5397.865053373618;5411.404745477994;5659.462351076641;5664.49019588239;5691.943080569225;5694.206325007609;5730.398308177665;5193.610479213999;5339.145736682112;5343.519083282523;5397.163439666858;5400.541853699479;3022.848857557113;3042.543618457249;3067.677893821117;3068.3709839482854;3107.5960125183583;5810;5926.8814623707285;5956.910646340309;5961.4038596140035;5961.552883533753;5664.688442135722;5733.971330143323;5753.194552762617;5777;5807.82576522705;5842.415758424208;5850.063989761617;5855.355910849803;5924.407559244128;5952.642841429615;5434.782608695607;5690.914636280377;5720.685362305113;5777.94222057774;5804.303483581997;5618.88762224745;5653.038983372754;5659.490645841894;5664.357336372406;5694.800681976111;5765.971170144123;5808.332041815076;5829.38791426911;5858.443447872616;5864.618799778001;3772.603876593028;3992.900177495586;4009.238244733608;4009.859654912064;4012.217617564547;5683.573731970201;5715.085586306171;5738.856528586652;5791.971040144772;5800.941990580209;5441;5462.91805622908;5631.070873306023;5648.57635677334;5652.745626446737;5620.4660557247;5630.296212973379;5633.549316054788;5647.830565083054;5654.2649455572155;5281.656692314988;5479.945200548103;5569.888602228014;5585.636933599303;5586.916196257141;5646.745896434588;5675.971620141873;5677.489025987681;5686.886262274814;5707.543396528351;5583.325002499153;5594.300712410949;5594.776208951596;5605.103183490785;5612.691301978431 16:31:16 INFO - PROCESS | 24644 | |5;yui.html;744.129368638693;746.7349091072673;774.17550308921;783.7217787685372;821.6713314674131;13202.339883005847;14761.557153285405;14997.47508837191;15006.849931500681;15018.174000429986;12973.870261297385;13231.404586793593;13638;13871.930640346809;13925.721485570282;697.7488104282479;779.8986131802858;788.0149812734082;791.4183075439547;832.8084540555645;840.3403328387217;841.9158084191594;842.0737189092011;842.2209456252972;842.2546046748611;891.7815135291862;893.9687110951118;894.2756367342473;894.9642014319419;895.5925054100369;729.6935287179398;855.3713020929612;876.7632739160455;888.2760550151605;890.7505898348472;638.3903372279508;638.865838173984;639.0318667219167;639.363832986177;639.389383139101;12944.417501212469;13071.346432678329;13076.86923130766;13083.542076027294;13087.41106650203;13073.803892941614;13251.602451926361;13288.180292495792;13514.59456216315;13641.86358136416;11560.59016295618;11605.303681779036;11749.177557570973;11902.880971190263;11943.104267179997;4326.178026175016;4396;4418.403515525395;4443.888902777424;4459.175052615276;53711;53737.99999999961;53815.46184538144;54064.45935540633;54444.183337249975;10365.118964887919;10561.207909406825;10651.946740266249;10782.299150555189;10944.124470042536;15980.041197528186;16523.83476165247;16989.830101698826;17097.059661718726;17108.74336884948;8031.317338026333;8318.334533237326;8378;8449.408541402043;8515.701950431705;4356.629686476622;4477.328400739915;4493.910121797546;4596.88507787308;4665.626749860003;3148.889788857379;3264.102371847761;3267.1015470745733;3267.330197309546;3276.950845737316;628.3502084574187;643.5045015338163;643.7811144210991;648.3840351665937;654.7741029344868;643.5559463969846;723.3525994235235;766.8811334243201;767.4090949968604;803.3091541274499;9361.90638093624;9674.806503869882;9691.2731545133;9698.127168554864;9773.853392199122;615.6398506873439;630.7256343490504;725.8947452619341;743.2493181886334;795.08168065884;4367.388565600819;4476.127155204704;4520.480144783326;4559.52125026874;4674.76626168697;63695.681521593026;65488;67129;68007.29981750496;68111;54150;55386.72306638522;56149;56524.43475565274;58389.12416313759;50958.74520627447;52481.475185248426;53531.73234133882;54167;54944.17583736247;8569.185927336894;8607.82784344297;8667.913320866963;8778.824423511367;8999.460032398078;33404.49893251555;33794.66205337915;34096.48855267223;34192.82903585466;34845.303093938484;41974.370384443646;45475.77262113668;46134.30798537957;46429.767851160526;47015.29477057915;10318.174546036149;10326.690199294033;10401.27191096616;10781.843631273934;10862.565497380016;12136.150469467053;12154.270743755404;12164.209326393757;12288.938555307166;12518.937405312916;11747.353895535827;11772.941135294268;12151.149419540547;12154.635360939186;12362.567310144103;11342.659720208407;11983.520659173535;12210.328431936328;12468.93765531203;12515.12394132402;11944.104192185447;12109.212901161396;12380.195287306657;12439.315837628656;12786.61640150797;10810.35137891729;11003.394813285346;11024.834627480755;11080.06341656777;11353.091752659602;11141.2201145919;11223.831642525533;11421;11485.885141148481;11579.652610421701 16:31:16 INFO - PROCESS | 24644 | __end_tp_report 16:31:16 INFO - PROCESS | 24644 | __start_cc_report 16:31:16 INFO - PROCESS | 24644 | _x_x_mozilla_cycle_collect,855 16:31:16 INFO - PROCESS | 24644 | __end_cc_report 16:31:16 INFO - PROCESS | 24644 | __startTimestamp1462836676163__endTimestamp 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | ------- Summary: start ------- 16:31:16 INFO - PROCESS | 24644 | Number of tests: 6 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | [#0] dojo.html Cycles:165 Average:5376.86 Median:5632.10 stddev:614.74 (10.9%) stddev-sans-first:591.52 16:31:16 INFO - PROCESS | 24644 | Values: 3160.6 3171.1 3189.8 3212.8 3229.2 5308.8 5318.1 5404.4 5501.2 5536.9 5275.4 5336.0 5341.9 5342.8 5369.2 4807.6 4827.6 4979.4 5019.1 5026.5 4821.5 4970.9 4988.9 5007.5 5040.1 4801.8 4808.9 4848.6 4857.9 4860.6 4849.6 4854.0 4862.9 4869.6 4896.8 4774.4 4787.1 4792.2 4803.5 4859.9 5325.8 5332.5 5338.7 5368.7 5383.9 5718.9 5720.1 5728.2 5773.6 5779.6 5700.4 5803.7 5803.8 5812.7 5846.3 5472.3 5510.7 5522.9 5526.6 5530.8 6017.7 6022.8 6032.5 6033.1 6034.2 5517.5 5632.1 5655.0 5697.1 5723.9 5793.8 5793.9 5796.0 5798.5 5799.6 5479.1 5771.7 5783.3 5783.8 5792.0 5763.6 5806.8 5835.1 5850.4 5855.5 4387.5 4425.1 4429.6 4431.8 4468.9 3869.1 3872.8 3971.7 3999.0 4009.9 5388.6 5396.9 5418.4 5432.3 5455.2 5794.1 5796.2 5797.8 5802.1 5809.2 5345.8 5442.6 5449.3 5449.6 5450.7 4984.3 5014.1 5017.1 5018.0 5054.6 6003.4 6008.1 6009.3 6012.5 6018.1 5604.2 5733.9 5822.5 5853.2 5855.1 5982.5 6008.7 6013.1 6014.4 6045.4 5667.3 5673.9 5705.0 5710.9 5722.3 5666.6 5722.4 5778.0 5790.8 5846.7 5659.4 5669.0 5669.7 5673.9 5687.5 5644.4 5661.6 5666.7 5671.5 5674.5 5420.9 5553.2 5622.4 5634.2 5672.8 5785.2 5807.3 5846.3 5848.7 5856.6 5442.1 5645.4 5692.9 5697.9 5742.1 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | [#1] ext.html Cycles:180 Average:61340.37 Median:40396.60 stddev:136497.27 (337.9%) stddev-sans-first:136803.99 16:31:16 INFO - PROCESS | 24644 | Values: 599.9 641.8 642.6 652.4 660.1 42010.6 43564.6 43625.3 43723.9 45735.0 43277.0 43705.0 43780.3 43812.6 43827.8 8710.1 8890.7 8901.4 8902.7 8904.8 8771.1 8842.7 8848.0 8854.0 8856.9 8877.3 8893.2 8901.3 8910.7 8915.2 8809.9 8849.4 8851.7 8851.8 8854.5 8709.3 8783.8 8784.1 8791.2 8791.8 40078.8 40381.8 40409.6 40494.4 40520.4 3630.3 3653.5 3664.5 3901.6 4274.6 30089.5 32303.7 32736.2 32762.7 33891.5 4282.2 4344.6 4370.0 4502.8 4568.3 309116.0 314447.0 314702.4 315310.0 316091.0 34920.8 35602.5 35773.5 35789.6 61648.7 37300.8 37454.8 37488.3 37513.4 37703.0 14465.0 14655.3 14656.2 14683.9 14683.9 12086.8 12204.9 12233.4 12246.3 12416.9 8665.7 8694.7 8719.2 8745.9 8812.6 3413.6 3436.9 3460.1 3471.3 3512.1 1022.1 1108.7 1117.9 1174.0 1234.8 31375.0 31896.5 32376.7 32619.3 33118.8 1094.8 1125.9 1144.5 1148.9 1224.9 17055.2 17113.6 17174.4 17188.0 17533.5 578083.0 591054.0 592106.0 869488.0 869814.0 55793.0 56905.1 56917.4 57009.7 57019.1 1390.3 1409.8 1425.5 1434.4 1445.8 30502.7 32639.5 32650.7 32722.0 32945.7 47328.0 47758.3 47786.8 47806.5 47847.5 403314.0 407088.0 407602.0 407897.0 408577.0 27549.7 28779.0 29004.3 29026.3 29070.6 45994.8 51067.6 51637.2 52508.0 52531.0 39405.0 39979.0 40383.6 40553.0 41148.4 40383.4 40694.8 40936.2 40993.4 41131.0 33414.7 41947.8 42757.8 43174.8 45815.5 34741.7 36154.8 36282.3 36365.8 36601.6 28410.3 28761.7 28834.0 28864.3 29450.3 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | [#2] jquery.html Cycles:180 Average:28210.10 Median:2238.85 stddev:82885.66 (3702.2%) stddev-sans-first:83091.87 16:31:16 INFO - PROCESS | 24644 | Values: 394.7 401.4 406.7 408.4 424.1 13051.4 17632.1 19313.7 19334.0 19721.1 14787.6 16365.7 17185.0 17515.7 18324.8 5524.0 5667.5 5704.5 5713.0 5718.2 5644.4 5668.3 5683.9 5688.2 5718.6 4069.3 4246.7 5960.2 6266.3 6270.2 6129.5 6286.5 6341.1 6341.8 6352.9 5427.1 5484.0 5495.9 5550.1 5552.4 22005.2 22046.2 22423.6 22870.7 23037.4 2607.6 2656.3 2663.8 2664.1 3026.6 13961.4 14332.2 14376.9 14428.4 14802.4 1969.9 2009.5 2012.0 2028.6 2062.5 69466.3 72757.6 73928.6 84564.0 84830.0 10142.4 10681.8 10894.1 10966.3 11032.2 15726.4 15808.1 15819.6 15827.4 15833.4 7625.2 7932.7 7993.6 8043.2 8081.5 7504.9 7524.4 7588.4 7709.1 7754.7 4378.6 4494.5 4748.8 4867.7 4902.6 1883.0 1889.2 1921.9 1987.7 1998.6 452.4 476.3 936.9 1040.2 1140.9 10985.2 11385.1 11620.4 11715.2 11737.0 458.5 465.1 467.9 470.7 481.7 5945.3 6159.4 6173.7 6221.4 6254.3 485071.0 495526.0 502885.0 506837.0 531330.0 55702.2 74984.0 88456.0 90145.1 94523.0 997.3 1018.7 1028.1 1032.3 1099.1 17268.7 17276.4 17280.6 17373.0 17597.6 34866.5 35328.3 36017.8 38135.4 41787.6 42816.8 53014.0 53122.5 53128.0 53241.0 8193.3 8225.7 8587.9 8654.0 8726.6 11600.7 12958.7 13099.7 13151.3 13195.7 6408.5 7745.4 11560.3 11606.4 11619.3 8397.7 11212.6 11462.4 11561.3 11758.0 11604.4 11665.9 11819.8 11898.4 11901.2 8325.9 8447.2 8513.9 8898.5 8989.3 10253.8 11739.0 11799.9 11880.8 12012.5 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | [#3] mootools.html Cycles:180 Average:5861.16 Median:4446.20 stddev:3439.06 (77.3%) stddev-sans-first:3431.78 16:31:16 INFO - PROCESS | 24644 | Values: 1319.9 1550.5 1554.0 1740.9 1860.5 8445.1 8704.7 8767.0 9001.5 9002.1 8769.8 8941.7 8943.0 8964.0 8981.7 1970.5 2040.8 2043.4 2269.2 2300.9 2242.8 2332.1 2332.5 2349.4 2354.1 2240.6 2253.8 2256.7 2264.6 2317.5 1962.7 2196.9 2265.9 2300.4 2303.7 2258.4 2294.7 2297.6 2297.7 2298.9 8656.9 8666.6 8689.3 8708.9 8710.1 4997.2 5128.2 5137.6 5160.3 5169.5 3130.2 3234.1 3345.1 3417.4 3424.7 998.4 1006.9 2130.2 2183.4 2185.5 12143.8 12368.4 12472.4 12654.8 13013.7 4324.7 4326.6 4385.2 4437.0 4455.4 9238.6 9258.6 9265.9 9278.4 9305.4 4867.1 4871.0 4905.1 4909.4 4917.8 4307.4 4471.1 4532.6 4579.8 4603.3 3766.8 3772.5 3829.5 3854.5 3877.1 1088.5 1109.0 1109.1 1116.6 1117.8 989.9 992.8 993.2 1005.1 1005.5 6081.7 6114.7 6175.8 6257.6 6273.0 432.1 433.1 433.5 436.6 438.6 4156.2 4189.6 4218.2 4237.8 4240.0 11232.7 11711.5 11776.1 11788.6 11803.6 11652.9 11657.5 11749.5 11751.6 11757.1 8172.0 8390.7 8617.5 8683.5 8709.0 6100.3 6124.6 6142.3 6192.6 6246.9 10447.8 10484.6 10730.7 10737.3 10858.1 10551.6 10670.9 10733.0 10741.6 10961.8 7101.3 7687.0 7884.3 7989.3 8113.6 8884.4 8898.0 8952.9 8986.9 8991.9 7724.7 7751.7 7796.3 8027.6 8069.9 7592.6 7713.6 7751.7 7796.9 7857.2 7086.0 7139.1 7149.4 7154.3 7161.9 4888.3 4944.3 5057.5 5153.9 5189.2 5355.0 5392.1 5406.9 5411.4 5456.7 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | [#4] prototype.html Cycles:180 Average:4691.99 Median:5401.93 stddev:1397.05 (25.9%) stddev-sans-first:1361.83 16:31:16 INFO - PROCESS | 24644 | Values: 317.1 319.2 324.3 327.7 328.4 5367.6 5403.3 5445.9 5454.4 5473.5 5353.7 5361.2 5367.8 5368.5 5375.5 3938.4 4036.6 4188.7 4193.8 4197.7 4133.6 4142.8 4158.4 4167.2 4184.8 3898.6 4107.9 4112.0 4126.5 4144.1 4018.6 4117.9 4118.8 4132.5 4135.7 3621.9 3650.0 3659.7 3660.2 3678.7 5156.6 5174.8 5178.8 5203.7 5208.7 4474.9 4691.2 4692.9 4738.3 4740.8 5616.2 5656.2 5657.3 5672.5 5697.3 3893.2 3930.9 3961.8 3986.5 3988.7 5608.3 5763.6 5804.8 5828.4 5832.8 3953.6 3974.1 3977.2 3978.1 3980.6 4053.5 4062.5 4075.7 4077.1 4078.1 4586.5 4625.6 4668.5 4692.6 4735.1 5574.4 5583.7 5586.5 5587.2 5609.5 1402.8 1406.5 1416.8 1420.5 1423.2 878.1 881.7 892.9 900.9 937.0 5275.7 5326.8 5366.4 5397.9 5411.4 5659.5 5664.5 5691.9 5694.2 5730.4 5193.6 5339.1 5343.5 5397.2 5400.5 3022.8 3042.5 3067.7 3068.4 3107.6 5810.0 5926.9 5956.9 5961.4 5961.6 5664.7 5734.0 5753.2 5777.0 5807.8 5842.4 5850.1 5855.4 5924.4 5952.6 5434.8 5690.9 5720.7 5777.9 5804.3 5618.9 5653.0 5659.5 5664.4 5694.8 5766.0 5808.3 5829.4 5858.4 5864.6 3772.6 3992.9 4009.2 4009.9 4012.2 5683.6 5715.1 5738.9 5792.0 5800.9 5441.0 5462.9 5631.1 5648.6 5652.7 5620.5 5630.3 5633.5 5647.8 5654.3 5281.7 5479.9 5569.9 5585.6 5586.9 5646.7 5676.0 5677.5 5686.9 5707.5 5583.3 5594.3 5594.8 5605.1 5612.7 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - PROCESS | 24644 | [#5] yui.html Cycles:180 Average:14857.80 Median:4507.20 stddev:17645.94 (391.5%) stddev-sans-first:17663.61 16:31:16 INFO - PROCESS | 24644 | Values: 744.1 746.7 774.2 783.7 821.7 13202.3 14761.6 14997.5 15006.8 15018.2 12973.9 13231.4 13638.0 13871.9 13925.7 697.7 779.9 788.0 791.4 832.8 840.3 841.9 842.1 842.2 842.3 891.8 894.0 894.3 895.0 895.6 729.7 855.4 876.8 888.3 890.8 638.4 638.9 639.0 639.4 639.4 12944.4 13071.3 13076.9 13083.5 13087.4 13073.8 13251.6 13288.2 13514.6 13641.9 11560.6 11605.3 11749.2 11902.9 11943.1 4326.2 4396.0 4418.4 4443.9 4459.2 53711.0 53738.0 53815.5 54064.5 54444.2 10365.1 10561.2 10651.9 10782.3 10944.1 15980.0 16523.8 16989.8 17097.1 17108.7 8031.3 8318.3 8378.0 8449.4 8515.7 4356.6 4477.3 4493.9 4596.9 4665.6 3148.9 3264.1 3267.1 3267.3 3277.0 628.4 643.5 643.8 648.4 654.8 643.6 723.4 766.9 767.4 803.3 9361.9 9674.8 9691.3 9698.1 9773.9 615.6 630.7 725.9 743.2 795.1 4367.4 4476.1 4520.5 4559.5 4674.8 63695.7 65488.0 67129.0 68007.3 68111.0 54150.0 55386.7 56149.0 56524.4 58389.1 50958.7 52481.5 53531.7 54167.0 54944.2 8569.2 8607.8 8667.9 8778.8 8999.5 33404.5 33794.7 34096.5 34192.8 34845.3 41974.4 45475.8 46134.3 46429.8 47015.3 10318.2 10326.7 10401.3 10781.8 10862.6 12136.2 12154.3 12164.2 12288.9 12518.9 11747.4 11772.9 12151.1 12154.6 12362.6 11342.7 11983.5 12210.3 12468.9 12515.1 11944.1 12109.2 12380.2 12439.3 12786.6 10810.4 11003.4 11024.8 11080.1 11353.1 11141.2 11223.8 11421.0 11485.9 11579.7 16:31:16 INFO - PROCESS | 24644 | -------- Summary: end -------- 16:31:16 INFO - PROCESS | 24644 | 16:31:16 INFO - TEST-INFO | 24644: exit 0 16:31:16 INFO - TEST-OK | dromaeo_css | took 1112643ms 16:31:16 INFO - TEST-START | kraken 16:31:16 INFO - operating with platform_type : linux_ 16:31:16 INFO - Initialising browser for kraken test... 16:31:16 INFO - TEST-INFO | started process 24827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhidOT/profile http://localhost:54801/getInfo.html) 16:31:20 INFO - PROCESS | 24827 | __metrics Screen width/height:1600/1200 16:31:20 INFO - PROCESS | 24827 | colorDepth:24 16:31:20 INFO - PROCESS | 24827 | Browser inner width/height: 1024/697 16:31:20 INFO - PROCESS | 24827 | __metrics 16:31:21 ERROR - PROCESS | 24827 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:31:22 INFO - TEST-INFO | 24827: exit 0 16:31:22 INFO - Browser initialized. 16:31:22 INFO - Running cycle 1/1 for kraken test... 16:31:22 INFO - TEST-INFO | started process 24908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhidOT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:34 INFO - PROCESS | 24908 | RSS: Main: 151965696 16:31:34 INFO - PROCESS | 24908 | 16:31:37 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54801/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:37 INFO - PROCESS | 24908 | RSS: Main: 207556608 16:31:37 INFO - PROCESS | 24908 | 16:31:40 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54801/tests/kraken/driver.html?testName=audio-dft) 16:31:41 INFO - PROCESS | 24908 | RSS: Main: 197537792 16:31:41 INFO - PROCESS | 24908 | 16:31:44 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54801/tests/kraken/driver.html?testName=audio-fft) 16:31:45 INFO - PROCESS | 24908 | RSS: Main: 264695808 16:31:45 INFO - PROCESS | 24908 | 16:31:47 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54801/tests/kraken/driver.html?testName=audio-oscillator) 16:31:47 INFO - PROCESS | 24908 | RSS: Main: 173899776 16:31:47 INFO - PROCESS | 24908 | 16:31:50 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54801/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:50 INFO - PROCESS | 24908 | RSS: Main: 178208768 16:31:50 INFO - PROCESS | 24908 | 16:31:53 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54801/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:54 INFO - PROCESS | 24908 | RSS: Main: 214032384 16:31:54 INFO - PROCESS | 24908 | 16:31:58 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54801/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:58 INFO - PROCESS | 24908 | RSS: Main: 214245376 16:31:58 INFO - PROCESS | 24908 | 16:32:01 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54801/tests/kraken/driver.html?testName=json-parse-financial) 16:32:02 INFO - PROCESS | 24908 | RSS: Main: 214388736 16:32:02 INFO - PROCESS | 24908 | 16:32:03 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54801/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:04 INFO - PROCESS | 24908 | RSS: Main: 203866112 16:32:04 INFO - PROCESS | 24908 | 16:32:06 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:06 INFO - PROCESS | 24908 | RSS: Main: 207966208 16:32:06 INFO - PROCESS | 24908 | 16:32:08 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:09 INFO - PROCESS | 24908 | RSS: Main: 216571904 16:32:09 INFO - PROCESS | 24908 | 16:32:12 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:12 INFO - PROCESS | 24908 | RSS: Main: 223707136 16:32:12 INFO - PROCESS | 24908 | 16:32:15 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:16 INFO - PROCESS | 24908 | RSS: Main: 219201536 16:32:16 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | Cycle 1(1): loaded http://localhost:54801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54801/tests/kraken/driver.html?testName=ai-astar) 16:32:18 INFO - PROCESS | 24908 | RSS: Main: 265084928 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | __start_tp_report 16:32:18 INFO - PROCESS | 24908 | _x_x_mozilla_page_load 16:32:18 INFO - PROCESS | 24908 | _x_x_mozilla_page_load_details 16:32:18 INFO - PROCESS | 24908 | |i|pagename|runs| 16:32:18 INFO - PROCESS | 24908 | |0;ai-astar;114;108;110;111;111;111;110;111;110;110 16:32:18 INFO - PROCESS | 24908 | |1;audio-beat-detection;163;124;154;213;126;153;161;132;194;125 16:32:18 INFO - PROCESS | 24908 | |2;audio-dft;160;160;160;161;160;161;162;162;161;162 16:32:18 INFO - PROCESS | 24908 | |3;audio-fft;75;76;75;140;76;74;74;75;126;76 16:32:18 INFO - PROCESS | 24908 | |4;audio-oscillator;91;92;155;93;92;91;135;91;92;126 16:32:18 INFO - PROCESS | 24908 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;117;116;116 16:32:18 INFO - PROCESS | 24908 | |6;imaging-darkroom;145;146;146;146;145;147;146;146;145;146 16:32:18 INFO - PROCESS | 24908 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 16:32:18 INFO - PROCESS | 24908 | |8;json-parse-financial;59;58;60;58;61;59;58;113;57;55 16:32:18 INFO - PROCESS | 24908 | |9;json-stringify-tinderbox;58;59;59;59;59;58;59;61;59;59 16:32:18 INFO - PROCESS | 24908 | |10;stanford-crypto-aes;79;78;78;79;83;80;81;85;86;80 16:32:18 INFO - PROCESS | 24908 | |11;stanford-crypto-ccm;125;126;126;142;124;128;121;129;191;130 16:32:18 INFO - PROCESS | 24908 | |12;stanford-crypto-pbkdf2;168;168;170;167;168;171;166;170;168;164 16:32:18 INFO - PROCESS | 24908 | |13;stanford-crypto-sha256-iterative;64;69;65;63;67;63;64;63;64;63 16:32:18 INFO - PROCESS | 24908 | __end_tp_report 16:32:18 INFO - PROCESS | 24908 | __start_cc_report 16:32:18 INFO - PROCESS | 24908 | _x_x_mozilla_cycle_collect,1837 16:32:18 INFO - PROCESS | 24908 | __end_cc_report 16:32:18 INFO - PROCESS | 24908 | __startTimestamp1462836738373__endTimestamp 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | ------- Summary: start ------- 16:32:18 INFO - PROCESS | 24908 | Number of tests: 14 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.51 (1.4%) stddev-sans-first:0.97 16:32:18 INFO - PROCESS | 24908 | Values: 114.0 108.0 110.0 111.0 111.0 111.0 110.0 111.0 110.0 110.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:157.50 stddev:30.22 (19.2%) stddev-sans-first:31.89 16:32:18 INFO - PROCESS | 24908 | Values: 163.0 124.0 154.0 213.0 126.0 153.0 161.0 132.0 194.0 125.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 16:32:18 INFO - PROCESS | 24908 | Values: 160.0 160.0 160.0 161.0 160.0 161.0 162.0 162.0 161.0 162.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.00 stddev:24.64 (32.8%) stddev-sans-first:25.76 16:32:18 INFO - PROCESS | 24908 | Values: 75.0 76.0 75.0 140.0 76.0 74.0 74.0 75.0 126.0 76.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:91.50 stddev:23.74 (25.9%) stddev-sans-first:24.57 16:32:18 INFO - PROCESS | 24908 | Values: 91.0 92.0 155.0 93.0 92.0 91.0 135.0 91.0 92.0 126.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:32:18 INFO - PROCESS | 24908 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:32:18 INFO - PROCESS | 24908 | Values: 145.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 146.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:32:18 INFO - PROCESS | 24908 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:58.50 stddev:17.36 (29.7%) stddev-sans-first:18.33 16:32:18 INFO - PROCESS | 24908 | Values: 59.0 58.0 60.0 58.0 61.0 59.0 58.0 113.0 57.0 55.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 16:32:18 INFO - PROCESS | 24908 | Values: 58.0 59.0 59.0 59.0 59.0 58.0 59.0 61.0 59.0 59.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:2.85 (3.5%) stddev-sans-first:2.93 16:32:18 INFO - PROCESS | 24908 | Values: 79.0 78.0 78.0 79.0 83.0 80.0 81.0 85.0 86.0 80.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:128.50 stddev:20.73 (16.1%) stddev-sans-first:21.72 16:32:18 INFO - PROCESS | 24908 | Values: 125.0 126.0 126.0 142.0 124.0 128.0 121.0 129.0 191.0 130.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.00 stddev:2.05 (1.2%) stddev-sans-first:2.18 16:32:18 INFO - PROCESS | 24908 | Values: 168.0 168.0 170.0 167.0 168.0 171.0 166.0 170.0 168.0 164.0 16:32:18 INFO - PROCESS | 24908 | 16:32:18 INFO - PROCESS | 24908 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 16:32:18 INFO - PROCESS | 24908 | Values: 64.0 69.0 65.0 63.0 67.0 63.0 64.0 63.0 64.0 63.0 16:32:18 INFO - PROCESS | 24908 | -------- Summary: end -------- 16:32:18 INFO - PROCESS | 24908 | 16:32:19 INFO - TEST-INFO | 24908: exit 0 16:32:19 INFO - TEST-OK | kraken | took 62529ms 16:32:19 INFO - SUITE-END | took 1175s 16:32:19 INFO - Completed test suite (00:19:35) 16:32:19 INFO - javascript benchmark 16:32:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.5891234139567, 3171.0962375722925, 3189.776715629906, 3212.8232947187894, 3229.1927018245437, 5308.787648494065, 5318.149096144618, 5404.351477822662, 5501.229827824103, 5536.944630553693, 5275.419703832585, 5336.039512887679, 5341.919871201935, 5342.813001544937, 5369.221462887888, 4807.61539076873, 4827.63792715546, 4979.427365852937, 5019.096562618727, 5026.472220416858, 4821.4696383397795, 4970.925436118461, 4988.925166122511, 5007.524285192919, 5040.067587496325, 4801.783919723621, 4808.903821923559, 4848.563629273364, 4857.878553036167, 4860.562549370538, 4849.612031037508, 4853.975730121362, 4862.854114376574, 4869.586085182764, 4896.779644915988, 4774.355462012619, 4787.090452813989, 4792.2332426811545, 4803.471618122038, 4859.927101093486, 5325.7869685212545, 5332.546733527654, 5338.652987555796, 5368.70472124033, 5383.946160538384, 5718.857028574277, 5720.056190728525, 5728.22668939692, 5773.566982476331, 5779.595428320019, 5700.37295897451, 5803.680797556132, 5803.767849286023, 5812.680302583356, 5846.269216347957, 5472.343318801769, 5510.6969116698565, 5522.861928451821, 5526.613137080406, 5530.834074977757, 6017.669028203403, 6022.849428764228, 6032.547558933097, 6033.064874944391, 6034.2155519782145, 5517.531009864127, 5632.098864181711, 5654.971725141348, 5697.116946873241, 5723.914141287884, 5793.826185214451, 5793.913091303634, 5796.043652797325, 5798.536117110621, 5799.594028417971, 5479.123340265618, 5771.68255745938, 5783.334916484658, 5783.797567085132, 5792.0, 5763.567732420085, 5806.79676211339, 5835.095560188178, 5850.414958504116, 5855.531557475391, 4387.517373088957, 4425.114977004612, 4429.623482004002, 4431.800568974404, 4468.888277793081, 3869.1487872667967, 3872.7676339419727, 3971.702122340836, 3998.960010399917, 4009.919801603952, 5388.595855310789, 5396.91904621431, 5418.4039755626845, 5432.293801805819, 5455.208994695826, 5794.072948328248, 5796.21751063601, 5797.768089276382, 5802.129680547867, 5809.186713860063, 5345.786168553214, 5442.564594832404, 5449.291592093082, 5449.618526703172, 5450.700211488406, 4984.252362145708, 5014.0974624567925, 5017.122003649347, 5018.0, 5054.620903432257, 6003.399660034049, 6008.098785182257, 6009.278886533644, 6012.458878700938, 6018.127371531104, 5604.215409842707, 5733.942660573341, 5822.475977162076, 5853.151293062568, 5855.092460668603, 5982.49148822355, 6008.669523176267, 6013.098035294741, 6014.36849130835, 6045.395460453919, 5667.263255776723, 5673.914891276551, 5704.971475142598, 5710.914336284876, 5722.341930678025, 5666.603337766317, 5722.427757224411, 5778.046622307273, 5790.7973220937065, 5846.707664616837, 5659.377468478382, 5669.036263835241, 5669.688167150846, 5673.886522269614, 5687.488126068673, 5644.3508996465935, 5661.575381846295, 5666.716664166857, 5671.517920976598, 5674.517665998436, 5420.864478388072, 5553.222548843084, 5622.437756224508, 5634.154876768517, 5672.801451949327, 5785.247917770663, 5807.332156802022, 5846.327672317568, 5848.736806843617, 5856.560757943086, 5442.102053161184, 5645.350784659817, 5692.886142277049, 5697.943020569741, 5742.138679197987], "value": 5335.668822212692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9040153575429, 641.8202903187108, 642.5983760149907, 652.367203812302, 660.112149159381, 42010.57989420105, 43564.564354356444, 43625.345619815685, 43723.90690232742, 45735.0, 43277.0, 43705.0, 43780.3432948506, 43812.561874381245, 43827.78086109573, 8710.128987101303, 8890.688825891095, 8901.376903616749, 8902.688405905794, 8904.821903561957, 8771.07903670115, 8842.690505832297, 8847.95576022119, 8854.0, 8856.911430885706, 8877.33419993503, 8893.199612034916, 8901.287896968259, 8910.732678019669, 8915.153060459246, 8809.867851982193, 8849.380543361967, 8851.690190843321, 8851.822963540757, 8854.513001784899, 8709.259712924346, 8783.824323513494, 8784.12158784123, 8791.164839340252, 8791.824163516758, 40078.79960600178, 40381.79809100965, 40409.59590404088, 40494.392584111265, 40520.392194117114, 3630.3283892479976, 3653.4702468142236, 3664.5052917856015, 3901.590333015021, 4274.5939135782055, 30089.548656770166, 32303.676963230537, 32736.181595460064, 32762.6723732762, 33891.491627625604, 4282.229198744225, 4344.565543445662, 4369.978150109261, 4502.842400515966, 4568.337591049312, 309116.0, 314447.0, 314702.42648786836, 315310.0, 316091.0, 34920.82539587286, 35602.465963010574, 35773.46339804905, 35789.64210357915, 61648.69175654093, 37300.81349593234, 37454.81272593619, 37488.25023499569, 37513.43729844054, 37703.0, 14465.0, 14655.34050967709, 14656.193909335088, 14683.853161468249, 14683.926580367244, 12086.818697719542, 12204.938975305067, 12233.388330583435, 12246.326452045223, 12416.875831241752, 8665.740027799176, 8694.739157825275, 8719.215270625675, 8745.868811967826, 8812.60343284541, 3413.573303337083, 3436.879709210166, 3460.1176699941857, 3471.3230919970365, 3512.121969507623, 1022.1311884897777, 1108.733903863067, 1117.932924024561, 1174.0196935558733, 1234.8332975048434, 31375.0, 31896.521552176735, 32376.705769691296, 32619.347613047605, 33118.834405827816, 1094.813881640123, 1125.9493322800495, 1144.4678224625422, 1148.8621365436202, 1224.865264820869, 17055.232514536874, 17113.572160696083, 17174.39889603858, 17188.0, 17533.473995779892, 578083.0, 591054.0, 592106.0, 869488.0, 869814.0, 55793.0, 56905.14642280369, 56917.43082569121, 57009.714951424976, 57019.144712829344, 1390.2770559309104, 1409.7532931736905, 1425.49394964786, 1434.4262295081842, 1445.768677011694, 30502.694973049984, 32639.510407343434, 32650.673493264763, 32722.0, 32945.67054329522, 47328.0, 47758.32845850517, 47786.76106619445, 47806.521934780205, 47847.52152478431, 403314.0, 407088.0, 407602.0, 407897.0, 408577.0, 27549.658279046507, 28779.0, 29004.27489312784, 29026.274343140747, 29070.56394154047, 45994.77002614966, 51067.642227862336, 51637.22544161916, 52508.0, 52531.0, 39405.0, 39979.00052498711, 40383.59616403798, 40553.0, 41148.38277425901, 40383.39424908687, 40694.79652601718, 40936.18127637371, 40993.385099224135, 41131.0, 33414.66585334213, 41947.790261048496, 42757.78621106874, 43174.78412607917, 45815.54184458246, 34741.65258347485, 36154.8192259037, 36282.27435451329, 36365.81817090898, 36601.63398365982, 28410.289742756595, 28761.712382875903, 28834.0, 28864.2783930395, 29450.263743406587], "value": 18956.326129386787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.72763792982823, 401.444000059917, 406.74171900842975, 408.3955745496663, 424.09032625019336, 13051.404998264832, 17632.11839408029, 19313.71029434558, 19334.0, 19721.112549935253, 14787.630309242275, 16365.672686546292, 17185.0, 17515.73726394105, 18324.81675183251, 5523.99999999999, 5667.546596272309, 5704.54363650909, 5713.028785106542, 5718.228039214694, 5644.379118296984, 5668.263125793641, 5683.886322273552, 5688.203651488774, 5718.628289161212, 4069.308217603015, 4246.7027308088445, 5960.1953736245705, 6266.342034086424, 6270.216222972129, 6129.509639228851, 6286.528510361742, 6341.112244285804, 6341.778037768679, 6352.9364706353035, 5427.131658934591, 5484.0, 5495.945040549584, 5550.111982082847, 5552.416996215379, 22005.22981695649, 22046.228382006713, 22423.55152896933, 22870.656940145913, 23037.424064398358, 2607.634931109646, 2656.296081538394, 2663.8002149838644, 2664.067576348282, 3026.636803583584, 13961.371738271802, 14332.211728354936, 14376.856231437761, 14428.350724217435, 14802.40790368384, 1969.901504924748, 2009.4875806669206, 2012.0, 2028.5739994601151, 2062.4740691123666, 69466.30533694649, 72757.63621181913, 73928.63035684841, 84564.0, 84830.0, 10142.44216568081, 10681.786364272672, 10894.128469722404, 10966.287191332538, 11032.227744058, 15726.449574264845, 15808.130552819704, 15819.604509887346, 15827.366905323888, 15833.445829395916, 7625.23747625233, 7932.682692692343, 7993.640286187136, 8043.195680432027, 8081.545321842125, 7504.924950750532, 7524.435667324863, 7588.430867684946, 7709.113451953097, 7754.728584499516, 4378.562143785596, 4494.483134439516, 4748.762561871962, 4867.659263851568, 4902.558769710743, 1882.9717554236697, 1889.1782074797507, 1921.903904804782, 1987.7415935928236, 1998.600279944017, 452.38249789037724, 476.28794951547656, 936.8922573903952, 1040.15747244732, 1140.912130800633, 10985.176111791647, 11385.14611404148, 11620.418979051183, 11715.1799374043, 11737.0, 458.5483298950531, 465.05361589166563, 467.93448917151625, 470.7410923991859, 481.7206020508097, 5945.316288626776, 6159.384061593805, 6173.722182501798, 6221.4089661482085, 6254.343293954069, 485071.0, 495526.0, 502885.0, 506837.0, 531330.0, 55702.16446753302, 74984.0, 88456.0, 90145.09854901498, 94523.0, 997.3218211616025, 1018.6842078955548, 1028.082625902686, 1032.3031953431405, 1099.1042300525207, 17268.654626907643, 17276.352935904742, 17280.567985800455, 17373.0, 17597.560060998065, 34866.47700284549, 35328.29343413066, 36017.819910900274, 38135.42796858105, 41787.582124179586, 42816.78591607022, 53014.0, 53122.468775311754, 53128.0, 53241.0, 8193.303569196685, 8225.71210007647, 8587.914120858712, 8653.95673021656, 8726.563671816511, 11600.709982250173, 12958.740825183631, 13099.738005240033, 13151.342432878126, 13195.67010824737, 6408.455281300955, 7745.419093568117, 11560.30638161713, 11606.361650109326, 11619.302841829518, 8397.70608028716, 11212.607558735404, 11462.426878655868, 11561.30632162073, 11758.0, 11604.361760102938, 11665.88334116648, 11819.763604728028, 11898.405079746151, 11901.166918315635, 8325.916740832514, 8447.197516235949, 8513.87229191575, 8898.510581918057, 8989.325800564853, 10253.84619230727, 11739.0, 11799.941000294944, 11880.762384752084, 12012.459439325427], "value": 8617.775751384019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.9208047517143, 1550.5348395481356, 1553.9766903496445, 1740.895546267224, 1860.5255659806746, 8445.11326310737, 8704.738857834267, 8767.0, 9001.50491722955, 9002.099790020995, 8769.824603507943, 8941.687040953568, 8943.0, 8964.0, 8981.730548083551, 1970.4679736471144, 2040.816326530612, 2043.4278402047375, 2269.1944359752256, 2300.907963681451, 2242.8317876159354, 2332.125452955142, 2332.5218330242346, 2349.4126468382906, 2354.117206047732, 2240.5630901974123, 2253.752087270399, 2256.717910261217, 2264.5810525052834, 2317.4669825940045, 1962.7154062660834, 2196.901139448729, 2265.8980345884393, 2300.4478925058033, 2303.7120359955006, 2258.3563684349883, 2294.66727324537, 2297.609406400899, 2297.689811875409, 2298.9310320690406, 8656.8701469478, 8666.6100025499, 8689.3048556116, 8708.912910870873, 8710.085441028728, 4997.175466048097, 5128.1794912813775, 5137.61467889906, 5160.25176349431, 5169.4572069932865, 3130.2174456385906, 3234.0782876879975, 3345.063382252973, 3417.3848707232687, 3424.7088997435, 998.4009594243469, 1006.9446180460071, 2130.222468798893, 2183.3886511776727, 2185.497335612802, 12143.757124857542, 12368.381580920917, 12472.376381180904, 12654.81017784734, 13013.739725205538, 4324.654027677778, 4326.58897404746, 4385.166818304576, 4436.977815110904, 4455.420795296591, 9238.630454781733, 9258.629654813732, 9265.861012084824, 9278.443293402417, 9305.441673499612, 4867.148249056401, 4871.0014447038275, 4905.068037072945, 4909.435414927258, 4917.7786999585105, 4307.418498502725, 4471.083427897273, 4532.5694059064335, 4579.771011449414, 4603.332516785114, 3766.7928263945196, 3772.5284339457567, 3829.483019792348, 3854.4603755474254, 3877.1470276539117, 1088.5101704233127, 1108.9944550277196, 1109.1293334732197, 1116.6147679050714, 1117.8267368557886, 989.8713167288206, 992.7666998255404, 993.1707024634367, 1005.0602686488157, 1005.4520286443759, 6081.726322315506, 6114.724837382329, 6175.752969881154, 6257.624542527463, 6273.027680709497, 432.1335721877615, 433.1272485940832, 433.46683579197764, 436.61141583990275, 438.6030642268688, 4156.189543039139, 4189.581041895786, 4218.156368726206, 4237.788110594458, 4240.0, 11232.66302010941, 11711.531538738525, 11776.057915366922, 11788.646340609796, 11803.586874459354, 11652.94173529127, 11657.533698652129, 11749.530018799323, 11751.647450576496, 11757.059435245159, 8172.0, 8390.706325278465, 8617.48295102296, 8683.478991260545, 8708.956455217683, 6100.267967843887, 6124.601900876429, 6142.262928448615, 6192.628442293477, 6246.937530624818, 10447.84328235062, 10484.580616775243, 10730.678079657622, 10737.302075365076, 10858.13134949218, 10551.577936882439, 10670.89329106699, 10733.0, 10741.570337186426, 10961.83557246626, 7101.2898710128575, 7686.961565192362, 7884.329831964347, 7989.2809647132035, 8113.594320283844, 8884.378093533649, 8898.02121766618, 8952.910470895467, 8986.910130898606, 8991.910080899108, 7724.652390642547, 7751.728689495841, 7796.259355361231, 8027.5584842834205, 8069.909492175365, 7592.620368981418, 7713.575753333621, 7751.728689495841, 7796.883046754417, 7857.214278572097, 7086.0, 7139.071920650283, 7149.392301654418, 7154.284571542804, 7161.856762864818, 4888.291197776373, 4944.258361245842, 5057.5448209659835, 5153.896922061613, 5189.247559103985, 5354.982553314858, 5392.137258038695, 5406.864828379322, 5411.350637923474, 5456.727163641882], "value": 4585.335632029773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.0504339503188, 319.16697419734487, 324.30598519168973, 327.68869573904794, 328.3629758268958, 5367.570594352447, 5403.324584426947, 5445.891082178359, 5454.427285135058, 5473.480019398151, 5353.732313384335, 5361.222622719703, 5367.765413954793, 5368.46315368463, 5375.489328513795, 3938.369860822276, 4036.636702696757, 4188.706790524665, 4193.832246710128, 4197.664186865043, 4133.586641335857, 4142.8135733891895, 4158.355454904495, 4167.166566686659, 4184.832606695729, 3898.6491215790575, 4107.938380924274, 4111.958880411203, 4126.484189476316, 4144.109016561454, 4018.618231268025, 4117.938230926538, 4118.814653340592, 4132.483439570054, 4135.676583493283, 3621.9275614487824, 3650.0, 3659.670629643345, 3660.194757153422, 3678.657290089125, 5156.613254005964, 5174.818881339135, 5178.818741344073, 5203.739813009334, 5208.713520756357, 4474.865754027384, 4691.249400096002, 4692.929606055878, 4738.265568836836, 4740.762961851894, 5616.241807356037, 5656.151577263402, 5657.2928383952, 5672.489475947144, 5697.31632204134, 3893.1824316893485, 3930.9213815723524, 3961.841526338943, 3986.54154772202, 3988.74073185242, 5608.270924779793, 5763.596548241625, 5804.825855224308, 5828.388019258002, 5832.825015249507, 3953.6046395360236, 3974.105826189142, 3977.2244412339896, 3978.1446988896946, 3980.5621381647998, 4053.5338436079637, 4062.532808727034, 4075.714699971033, 4077.062275676611, 4078.1232035112, 4586.541345865454, 4625.606823419979, 4668.4631267404, 4692.592222333286, 4735.12400205963, 5574.414686457863, 5583.74873130702, 5586.469285417878, 5587.161925711176, 5609.49514543693, 1402.8036074949516, 1406.528812847687, 1416.7886457079255, 1420.453125546672, 1423.224342733192, 878.0780180810124, 881.6870011146079, 892.8526793079199, 900.8513595256841, 937.0, 5275.709835959059, 5326.840194794162, 5366.436524164985, 5397.865053373618, 5411.404745477994, 5659.462351076641, 5664.49019588239, 5691.943080569225, 5694.206325007609, 5730.398308177665, 5193.610479213999, 5339.145736682112, 5343.519083282523, 5397.163439666858, 5400.541853699479, 3022.848857557113, 3042.543618457249, 3067.677893821117, 3068.3709839482854, 3107.5960125183583, 5810.0, 5926.8814623707285, 5956.910646340309, 5961.4038596140035, 5961.552883533753, 5664.688442135722, 5733.971330143323, 5753.194552762617, 5777.0, 5807.82576522705, 5842.415758424208, 5850.063989761617, 5855.355910849803, 5924.407559244128, 5952.642841429615, 5434.782608695607, 5690.914636280377, 5720.685362305113, 5777.94222057774, 5804.303483581997, 5618.88762224745, 5653.038983372754, 5659.490645841894, 5664.357336372406, 5694.800681976111, 5765.971170144123, 5808.332041815076, 5829.38791426911, 5858.443447872616, 5864.618799778001, 3772.603876593028, 3992.900177495586, 4009.238244733608, 4009.859654912064, 4012.217617564547, 5683.573731970201, 5715.085586306171, 5738.856528586652, 5791.971040144772, 5800.941990580209, 5441.0, 5462.91805622908, 5631.070873306023, 5648.57635677334, 5652.745626446737, 5620.4660557247, 5630.296212973379, 5633.549316054788, 5647.830565083054, 5654.2649455572155, 5281.656692314988, 5479.945200548103, 5569.888602228014, 5585.636933599303, 5586.916196257141, 5646.745896434588, 5675.971620141873, 5677.489025987681, 5686.886262274814, 5707.543396528351, 5583.325002499153, 5594.300712410949, 5594.776208951596, 5605.103183490785, 5612.691301978431], "value": 4239.978276626422, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.129368638693, 746.7349091072673, 774.17550308921, 783.7217787685372, 821.6713314674131, 13202.339883005847, 14761.557153285405, 14997.47508837191, 15006.849931500681, 15018.174000429986, 12973.870261297385, 13231.404586793593, 13638.0, 13871.930640346809, 13925.721485570282, 697.7488104282479, 779.8986131802858, 788.0149812734082, 791.4183075439547, 832.8084540555645, 840.3403328387217, 841.9158084191594, 842.0737189092011, 842.2209456252972, 842.2546046748611, 891.7815135291862, 893.9687110951118, 894.2756367342473, 894.9642014319419, 895.5925054100369, 729.6935287179398, 855.3713020929612, 876.7632739160455, 888.2760550151605, 890.7505898348472, 638.3903372279508, 638.865838173984, 639.0318667219167, 639.363832986177, 639.389383139101, 12944.417501212469, 13071.346432678329, 13076.86923130766, 13083.542076027294, 13087.41106650203, 13073.803892941614, 13251.602451926361, 13288.180292495792, 13514.59456216315, 13641.86358136416, 11560.59016295618, 11605.303681779036, 11749.177557570973, 11902.880971190263, 11943.104267179997, 4326.178026175016, 4396.0, 4418.403515525395, 4443.888902777424, 4459.175052615276, 53711.0, 53737.99999999961, 53815.46184538144, 54064.45935540633, 54444.183337249975, 10365.118964887919, 10561.207909406825, 10651.946740266249, 10782.299150555189, 10944.124470042536, 15980.041197528186, 16523.83476165247, 16989.830101698826, 17097.059661718726, 17108.74336884948, 8031.317338026333, 8318.334533237326, 8378.0, 8449.408541402043, 8515.701950431705, 4356.629686476622, 4477.328400739915, 4493.910121797546, 4596.88507787308, 4665.626749860003, 3148.889788857379, 3264.102371847761, 3267.1015470745733, 3267.330197309546, 3276.950845737316, 628.3502084574187, 643.5045015338163, 643.7811144210991, 648.3840351665937, 654.7741029344868, 643.5559463969846, 723.3525994235235, 766.8811334243201, 767.4090949968604, 803.3091541274499, 9361.90638093624, 9674.806503869882, 9691.2731545133, 9698.127168554864, 9773.853392199122, 615.6398506873439, 630.7256343490504, 725.8947452619341, 743.2493181886334, 795.08168065884, 4367.388565600819, 4476.127155204704, 4520.480144783326, 4559.52125026874, 4674.76626168697, 63695.681521593026, 65488.0, 67129.0, 68007.29981750496, 68111.0, 54150.0, 55386.72306638522, 56149.0, 56524.43475565274, 58389.12416313759, 50958.74520627447, 52481.475185248426, 53531.73234133882, 54167.0, 54944.17583736247, 8569.185927336894, 8607.82784344297, 8667.913320866963, 8778.824423511367, 8999.460032398078, 33404.49893251555, 33794.66205337915, 34096.48855267223, 34192.82903585466, 34845.303093938484, 41974.370384443646, 45475.77262113668, 46134.30798537957, 46429.767851160526, 47015.29477057915, 10318.174546036149, 10326.690199294033, 10401.27191096616, 10781.843631273934, 10862.565497380016, 12136.150469467053, 12154.270743755404, 12164.209326393757, 12288.938555307166, 12518.937405312916, 11747.353895535827, 11772.941135294268, 12151.149419540547, 12154.635360939186, 12362.567310144103, 11342.659720208407, 11983.520659173535, 12210.328431936328, 12468.93765531203, 12515.12394132402, 11944.104192185447, 12109.212901161396, 12380.195287306657, 12439.315837628656, 12786.61640150797, 10810.35137891729, 11003.394813285346, 11024.834627480755, 11080.06341656777, 11353.091752659602, 11141.2201145919, 11223.831642525533, 11421.0, 11485.885141148481, 11579.652610421701], "value": 6714.866372768628, "unit": "score"}], "name": "dromaeo_css", "value": 6961.327911724174, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 110.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 124.0, 154.0, 213.0, 126.0, 153.0, 161.0, 132.0, 194.0, 125.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 140.0, 76.0, 74.0, 74.0, 75.0, 126.0, 76.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 155.0, 93.0, 92.0, 91.0, 135.0, 91.0, 92.0, 126.0], "value": 105.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 60.0, 58.0, 61.0, 59.0, 58.0, 113.0, 57.0, 55.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 61.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 83.0, 80.0, 81.0, 85.0, 86.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 126.0, 142.0, 124.0, 128.0, 121.0, 129.0, 191.0, 130.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 170.0, 167.0, 168.0, 171.0, 166.0, 170.0, 168.0, 164.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 65.0, 63.0, 67.0, 63.0, 64.0, 63.0, 64.0, 63.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1546.3000000000002, "alertThreshold": 2.0}]} 16:32:19 INFO - Return code: 0 16:32:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:32:19 ERROR - # TBPL SUCCESS # 16:32:19 INFO - Running post-action listener: _resource_record_post_action 16:32:19 INFO - ##### 16:32:19 INFO - ##### Finished run-tests step (success) 16:32:19 INFO - ##### 16:32:19 INFO - Running post-run listener: _resource_record_post_run 16:32:20 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 534499328; Read time: 0; Write time: 541292 16:32:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244858880; Read time: 0; Write time: 277096 16:32:20 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289640448; Read time: 0; Write time: 264196 16:32:20 INFO - Running post-run listener: _upload_blobber_files 16:32:20 INFO - Blob upload gear active. 16:32:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:32:20 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:32:20 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:32:21 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:21 INFO - (blobuploader) - INFO - Done attempting. 16:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:32:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:22 INFO - (blobuploader) - INFO - Done attempting. 16:32:22 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:22 INFO - Return code: 0 16:32:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c1f4068344c85e2177e8c9cdf66bff1ecfaa72eb1adc05972a3a7990d8e47383ca499a91781f1607e730293fb6d38a3a3c0760ec59ee0653c109ce0b10981a06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce097c2b962b359eba7652c415647e5af0954709209e7bcc269919b6cecdc628ecc599d33781c01ce400b978edacdbbeec4efdbbbe7b19ba4a741fe5f4089057"} 16:32:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:22 INFO - Contents: 16:32:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c1f4068344c85e2177e8c9cdf66bff1ecfaa72eb1adc05972a3a7990d8e47383ca499a91781f1607e730293fb6d38a3a3c0760ec59ee0653c109ce0b10981a06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce097c2b962b359eba7652c415647e5af0954709209e7bcc269919b6cecdc628ecc599d33781c01ce400b978edacdbbeec4efdbbbe7b19ba4a741fe5f4089057"} 16:32:22 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:22 INFO - Copying logs to upload dir... 16:32:22 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.257000 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-09 16:32:22.443961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:22.447048) ========= 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=836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c1f4068344c85e2177e8c9cdf66bff1ecfaa72eb1adc05972a3a7990d8e47383ca499a91781f1607e730293fb6d38a3a3c0760ec59ee0653c109ce0b10981a06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce097c2b962b359eba7652c415647e5af0954709209e7bcc269919b6cecdc628ecc599d33781c01ce400b978edacdbbeec4efdbbbe7b19ba4a741fe5f4089057"} build_url:https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011036 build_url: 'https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/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/Mozilla-Inbound/sha512/c1f4068344c85e2177e8c9cdf66bff1ecfaa72eb1adc05972a3a7990d8e47383ca499a91781f1607e730293fb6d38a3a3c0760ec59ee0653c109ce0b10981a06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce097c2b962b359eba7652c415647e5af0954709209e7bcc269919b6cecdc628ecc599d33781c01ce400b978edacdbbeec4efdbbbe7b19ba4a741fe5f4089057"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:22.471074) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:22.471365) ========= 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=836cfdc75598d54cb747368e000001a9-1462834954.325326-900742920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:22.553731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:32:22.554050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:32:22.554359) ========= ========= Total master_lag: 0.16 =========