builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1461263533.64 results: success (0) buildid: 20160421110016 builduid: 7bb95e9d9f4049b387b9a0d6fec08b2c revision: fed6d478bf3d7cc80fbcf975361a2e2bc8e4ed30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.638601) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.639085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.639371) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.755760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.756131) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 11:32:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-04-21 11:32:14 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.931702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.932035) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050436 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.990246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:13.990599) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fed6d478bf3d7cc80fbcf975361a2e2bc8e4ed30 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fed6d478bf3d7cc80fbcf975361a2e2bc8e4ed30 --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=5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 11:32:14,256 truncating revision to first 12 chars 2016-04-21 11:32:14,256 Setting DEBUG logging. 2016-04-21 11:32:14,256 attempt 1/10 2016-04-21 11:32:14,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fed6d478bf3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 11:32:14,504 unpacking tar archive at: fx-team-fed6d478bf3d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:14.529227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:14.529553) ========= script_repo_revision: fed6d478bf3d7cc80fbcf975361a2e2bc8e4ed30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:14.529971) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:14.530280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 11:32:14.539612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-21 11:32:14.539938) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:32:15 INFO - MultiFileLogger online at 20160421 11:32:15 in /builds/slave/test 11:32:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:32:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:32:15 INFO - {'append_to_log': False, 11:32:15 INFO - 'base_work_dir': '/builds/slave/test', 11:32:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:32:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:32:15 INFO - 'branch': 'Fx-Team-Non-PGO', 11:32:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:15 INFO - 'config_files': ('talos/linux_config.py',), 11:32:15 INFO - 'default_actions': ('clobber', 11:32:15 INFO - 'read-buildbot-config', 11:32:15 INFO - 'download-and-extract', 11:32:15 INFO - 'populate-webroot', 11:32:15 INFO - 'create-virtualenv', 11:32:15 INFO - 'install', 11:32:15 INFO - 'run-tests'), 11:32:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:15 INFO - 'download_minidump_stackwalk': True, 11:32:15 INFO - 'download_symbols': 'ondemand', 11:32:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:32:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:32:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:32:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:32:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:15 INFO - 'installer_path': 'installer.exe', 11:32:15 INFO - 'log_level': 'info', 11:32:15 INFO - 'log_name': 'talos', 11:32:15 INFO - 'log_to_console': True, 11:32:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:32:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:32:15 INFO - 'opt_config_files': (), 11:32:15 INFO - 'pip_index': False, 11:32:15 INFO - 'sps_profile': False, 11:32:15 INFO - 'sps_profile_interval': 0, 11:32:15 INFO - 'suite': 'dromaeojs', 11:32:15 INFO - 'system_bits': '32', 11:32:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:15 INFO - 'title': 'talos-linux64-ix-051', 11:32:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:32:15 INFO - 'use_talos_json': True, 11:32:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:32:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:15 INFO - 'work_dir': 'build'} 11:32:15 INFO - ##### 11:32:15 INFO - ##### Running clobber step. 11:32:15 INFO - ##### 11:32:15 INFO - Running pre-action listener: _resource_record_pre_action 11:32:15 INFO - Running main action method: clobber 11:32:15 INFO - rmtree: /builds/slave/test/build 11:32:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:32:17 INFO - Running post-action listener: _resource_record_post_action 11:32:17 INFO - ##### 11:32:17 INFO - ##### Running read-buildbot-config step. 11:32:17 INFO - ##### 11:32:17 INFO - Running pre-action listener: _resource_record_pre_action 11:32:17 INFO - Running main action method: read_buildbot_config 11:32:17 INFO - Using buildbot properties: 11:32:17 INFO - { 11:32:17 INFO - "project": "", 11:32:17 INFO - "product": "firefox", 11:32:17 INFO - "script_repo_revision": "production", 11:32:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:32:17 INFO - "repository": "", 11:32:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:32:17 INFO - "buildid": "20160421110016", 11:32:17 INFO - "pgo_build": "False", 11:32:17 INFO - "basedir": "/builds/slave/test", 11:32:17 INFO - "buildnumber": 2856, 11:32:17 INFO - "slavename": "talos-linux64-ix-051", 11:32:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:32:17 INFO - "platform": "ubuntu64_hw", 11:32:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:32:17 INFO - "branch": "fx-team", 11:32:17 INFO - "repo_path": "integration/fx-team", 11:32:17 INFO - "revision": "fed6d478bf3d7cc80fbcf975361a2e2bc8e4ed30", 11:32:17 INFO - "stage_platform": "linux64", 11:32:17 INFO - "builduid": "7bb95e9d9f4049b387b9a0d6fec08b2c", 11:32:17 INFO - "slavebuilddir": "test" 11:32:17 INFO - } 11:32:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:32:17 INFO - Running post-action listener: _resource_record_post_action 11:32:17 INFO - ##### 11:32:17 INFO - ##### Running download-and-extract step. 11:32:17 INFO - ##### 11:32:17 INFO - Running pre-action listener: _resource_record_pre_action 11:32:17 INFO - Running main action method: download_and_extract 11:32:17 INFO - mkdir: /builds/slave/test/build/tests 11:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:17 INFO - https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:32:21 INFO - Downloaded 1361 bytes. 11:32:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:32:21 INFO - Using the following test package requirements: 11:32:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:32:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:32:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'jsshell-linux-x86_64.zip'], 11:32:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:32:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:32:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:32:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:32:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:32:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:21 INFO - https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:32:23 INFO - Downloaded 22275480 bytes. 11:32:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:32:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:32:25 INFO - Return code: 0 11:32:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:25 INFO - https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:32:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:32:34 INFO - Downloaded 22275480 bytes. 11:32:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:32:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:32:35 INFO - Return code: 0 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:35 INFO - https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:32:38 INFO - Downloaded 10845952 bytes. 11:32:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:32:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:32:38 INFO - Return code: 0 11:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:38 INFO - https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:32:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:32:39 INFO - Downloaded 54624439 bytes. 11:32:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:39 INFO - mkdir: /builds/slave/test/properties 11:32:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:32:39 INFO - Writing to file /builds/slave/test/properties/build_url 11:32:39 INFO - Contents: 11:32:39 INFO - build_url:https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:40 INFO - Running post-action listener: _resource_record_post_action 11:32:40 INFO - Running post-action listener: set_extra_try_arguments 11:32:40 INFO - ##### 11:32:40 INFO - ##### Running populate-webroot step. 11:32:40 INFO - ##### 11:32:40 INFO - Running pre-action listener: _resource_record_pre_action 11:32:40 INFO - Running main action method: populate_webroot 11:32:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:32:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:32:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:32:40 INFO - '--tppagecycles', 11:32:40 INFO - '7'], 11:32:40 INFO - 'tests': ['tsvgm']}}, 11:32:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:32:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:32:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:32:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:32:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['damp', 'tps']}, 11:32:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'tests': ['damp', 'tps']}, 11:32:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['dromaeo_dom']}, 11:32:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['a11yr', 11:32:40 INFO - 'ts_paint', 11:32:40 INFO - 'tpaint', 11:32:40 INFO - 'sessionrestore', 11:32:40 INFO - 'sessionrestore_no_auto_restore', 11:32:40 INFO - 'tabpaint']}, 11:32:40 INFO - 'other-e10s': {'tests': ['a11yr', 11:32:40 INFO - 'ts_paint', 11:32:40 INFO - 'tpaint', 11:32:40 INFO - 'sessionrestore', 11:32:40 INFO - 'sessionrestore_no_auto_restore', 11:32:40 INFO - 'tabpaint']}, 11:32:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:32:40 INFO - 'ts_paint', 11:32:40 INFO - 'tpaint', 11:32:40 INFO - 'sessionrestore', 11:32:40 INFO - 'sessionrestore_no_auto_restore', 11:32:40 INFO - 'tabpaint']}, 11:32:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:32:40 INFO - 'ts_paint', 11:32:40 INFO - 'tpaint', 11:32:40 INFO - 'sessionrestore', 11:32:40 INFO - 'sessionrestore_no_auto_restore', 11:32:40 INFO - 'tabpaint']}, 11:32:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['a11yr', 11:32:40 INFO - 'ts_paint', 11:32:40 INFO - 'tpaint', 11:32:40 INFO - 'sessionrestore', 11:32:40 INFO - 'sessionrestore_no_auto_restore', 11:32:40 INFO - 'tabpaint']}, 11:32:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['a11yr', 11:32:40 INFO - 'ts_paint', 11:32:40 INFO - 'tpaint', 11:32:40 INFO - 'sessionrestore', 11:32:40 INFO - 'sessionrestore_no_auto_restore', 11:32:40 INFO - 'tabpaint']}, 11:32:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['tsvgx', 11:32:40 INFO - 'tsvgr_opacity', 11:32:40 INFO - 'tart', 11:32:40 INFO - 'tscrollx', 11:32:40 INFO - 'cart']}, 11:32:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:32:40 INFO - 'tsvgr_opacity', 11:32:40 INFO - 'tart', 11:32:40 INFO - 'tscrollx', 11:32:40 INFO - 'cart']}, 11:32:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'talos_options': ['--disable-e10s'], 11:32:40 INFO - 'tests': ['tp5o']}, 11:32:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'tests': ['tp5o']}, 11:32:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'talos_options': ['--disable-e10s', 11:32:40 INFO - '--xperf_path', 11:32:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:40 INFO - 'tests': ['tp5n']}, 11:32:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:40 INFO - 'talos_options': ['--xperf_path', 11:32:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:40 INFO - 'tests': ['tp5n']}}, 11:32:40 INFO - 'talos.zip': {'path': '', 11:32:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:32:40 INFO - Running post-action listener: _resource_record_post_action 11:32:40 INFO - ##### 11:32:40 INFO - ##### Running create-virtualenv step. 11:32:40 INFO - ##### 11:32:40 INFO - Running pre-action listener: _resource_record_pre_action 11:32:40 INFO - Running main action method: create_virtualenv 11:32:40 INFO - Creating virtualenv /builds/slave/test/build/venv 11:32:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:32:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:32:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:40 INFO - Using real prefix '/usr' 11:32:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:32:41 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:43 INFO - Installing pip.................done. 11:32:43 INFO - Return code: 0 11:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:43 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:32:43 INFO - Using env: {'DISPLAY': ':0', 11:32:43 INFO - 'HOME': '/home/cltbld', 11:32:43 INFO - 'LANG': 'en_US.UTF-8', 11:32:43 INFO - 'LANGUAGE': 'en_US:en', 11:32:43 INFO - 'LOGNAME': 'cltbld', 11:32:43 INFO - 'MAIL': '/var/mail/cltbld', 11:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:43 INFO - 'MOZ_NO_REMOTE': '1', 11:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:43 INFO - 'NO_EM_RESTART': '1', 11:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:43 INFO - 'PWD': '/builds/slave/test', 11:32:43 INFO - 'SHELL': '/bin/bash', 11:32:43 INFO - 'SHLVL': '1', 11:32:43 INFO - 'TERM': 'linux', 11:32:43 INFO - 'TMOUT': '86400', 11:32:43 INFO - 'USER': 'cltbld', 11:32:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:43 INFO - '_': '/tools/buildbot/bin/python'} 11:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:32:43 INFO - Cleaning up... 11:32:43 INFO - Return code: 0 11:32:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:43 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:32:43 INFO - Using env: {'DISPLAY': ':0', 11:32:43 INFO - 'HOME': '/home/cltbld', 11:32:43 INFO - 'LANG': 'en_US.UTF-8', 11:32:43 INFO - 'LANGUAGE': 'en_US:en', 11:32:43 INFO - 'LOGNAME': 'cltbld', 11:32:43 INFO - 'MAIL': '/var/mail/cltbld', 11:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:43 INFO - 'MOZ_NO_REMOTE': '1', 11:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:43 INFO - 'NO_EM_RESTART': '1', 11:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:43 INFO - 'PWD': '/builds/slave/test', 11:32:43 INFO - 'SHELL': '/bin/bash', 11:32:43 INFO - 'SHLVL': '1', 11:32:43 INFO - 'TERM': 'linux', 11:32:43 INFO - 'TMOUT': '86400', 11:32:43 INFO - 'USER': 'cltbld', 11:32:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:43 INFO - '_': '/tools/buildbot/bin/python'} 11:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:44 INFO - Downloading/unpacking psutil>=0.7.1 11:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:46 INFO - Installing collected packages: psutil 11:32:46 INFO - Running setup.py install for psutil 11:32:46 INFO - building 'psutil._psutil_linux' extension 11:32:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:32:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:32:47 INFO - building 'psutil._psutil_posix' extension 11:32:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:32:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:47 INFO - Successfully installed psutil 11:32:47 INFO - Cleaning up... 11:32:47 INFO - Return code: 0 11:32:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:47 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:32:47 INFO - Using env: {'DISPLAY': ':0', 11:32:47 INFO - 'HOME': '/home/cltbld', 11:32:47 INFO - 'LANG': 'en_US.UTF-8', 11:32:47 INFO - 'LANGUAGE': 'en_US:en', 11:32:47 INFO - 'LOGNAME': 'cltbld', 11:32:47 INFO - 'MAIL': '/var/mail/cltbld', 11:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:47 INFO - 'MOZ_NO_REMOTE': '1', 11:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:47 INFO - 'NO_EM_RESTART': '1', 11:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:47 INFO - 'PWD': '/builds/slave/test', 11:32:47 INFO - 'SHELL': '/bin/bash', 11:32:47 INFO - 'SHLVL': '1', 11:32:47 INFO - 'TERM': 'linux', 11:32:47 INFO - 'TMOUT': '86400', 11:32:47 INFO - 'USER': 'cltbld', 11:32:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:47 INFO - '_': '/tools/buildbot/bin/python'} 11:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:32:49 INFO - Installing collected packages: mozsystemmonitor 11:32:49 INFO - Running setup.py install for mozsystemmonitor 11:32:49 INFO - Successfully installed mozsystemmonitor 11:32:49 INFO - Cleaning up... 11:32:50 INFO - Return code: 0 11:32:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:32:50 INFO - Using env: {'DISPLAY': ':0', 11:32:50 INFO - 'HOME': '/home/cltbld', 11:32:50 INFO - 'LANG': 'en_US.UTF-8', 11:32:50 INFO - 'LANGUAGE': 'en_US:en', 11:32:50 INFO - 'LOGNAME': 'cltbld', 11:32:50 INFO - 'MAIL': '/var/mail/cltbld', 11:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:50 INFO - 'MOZ_NO_REMOTE': '1', 11:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:50 INFO - 'NO_EM_RESTART': '1', 11:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:50 INFO - 'PWD': '/builds/slave/test', 11:32:50 INFO - 'SHELL': '/bin/bash', 11:32:50 INFO - 'SHLVL': '1', 11:32:50 INFO - 'TERM': 'linux', 11:32:50 INFO - 'TMOUT': '86400', 11:32:50 INFO - 'USER': 'cltbld', 11:32:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:50 INFO - '_': '/tools/buildbot/bin/python'} 11:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:52 INFO - Downloading docopt-0.6.1.tar.gz 11:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:52 INFO - Running setup.py install for blobuploader 11:32:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:52 INFO - Running setup.py install for requests 11:32:53 INFO - Running setup.py install for docopt 11:32:53 INFO - Successfully installed blobuploader requests docopt 11:32:53 INFO - Cleaning up... 11:32:53 INFO - Return code: 0 11:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:53 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:32:53 INFO - Using env: {'DISPLAY': ':0', 11:32:53 INFO - 'HOME': '/home/cltbld', 11:32:53 INFO - 'LANG': 'en_US.UTF-8', 11:32:53 INFO - 'LANGUAGE': 'en_US:en', 11:32:53 INFO - 'LOGNAME': 'cltbld', 11:32:53 INFO - 'MAIL': '/var/mail/cltbld', 11:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:53 INFO - 'MOZ_NO_REMOTE': '1', 11:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:53 INFO - 'NO_EM_RESTART': '1', 11:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:53 INFO - 'PWD': '/builds/slave/test', 11:32:53 INFO - 'SHELL': '/bin/bash', 11:32:53 INFO - 'SHLVL': '1', 11:32:53 INFO - 'TERM': 'linux', 11:32:53 INFO - 'TMOUT': '86400', 11:32:53 INFO - 'USER': 'cltbld', 11:32:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:53 INFO - '_': '/tools/buildbot/bin/python'} 11:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:53 INFO - Running setup.py (path:/tmp/pip-r4ntwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:53 INFO - Running setup.py (path:/tmp/pip-9UCfxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:53 INFO - Running setup.py (path:/tmp/pip-RQbjqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:53 INFO - Running setup.py (path:/tmp/pip-gWxd0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:53 INFO - Running setup.py (path:/tmp/pip-tuwTce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:54 INFO - Running setup.py (path:/tmp/pip-sVGwLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:54 INFO - Running setup.py (path:/tmp/pip-vS__9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:54 INFO - Running setup.py (path:/tmp/pip-DS_29F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:54 INFO - Running setup.py (path:/tmp/pip-T3mlvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:54 INFO - Running setup.py (path:/tmp/pip-p4HCPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:54 INFO - Running setup.py (path:/tmp/pip-lV87xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:54 INFO - Running setup.py (path:/tmp/pip-N7Ddsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:54 INFO - Running setup.py (path:/tmp/pip-u0R0VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:54 INFO - Running setup.py (path:/tmp/pip-eX7Xkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:54 INFO - Running setup.py (path:/tmp/pip-Bt8WXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:54 INFO - Running setup.py (path:/tmp/pip-00zktl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:54 INFO - Running setup.py (path:/tmp/pip-8QNaSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:54 INFO - Running setup.py install for manifestparser 11:32:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:54 INFO - Running setup.py install for mozcrash 11:32:55 INFO - Running setup.py install for mozdebug 11:32:55 INFO - Running setup.py install for mozdevice 11:32:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Running setup.py install for mozfile 11:32:55 INFO - Running setup.py install for mozhttpd 11:32:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Running setup.py install for mozinfo 11:32:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Running setup.py install for mozInstall 11:32:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Running setup.py install for mozleak 11:32:55 INFO - Running setup.py install for mozlog 11:32:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:55 INFO - Running setup.py install for moznetwork 11:32:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozprocess 11:32:56 INFO - Running setup.py install for mozprofile 11:32:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozrunner 11:32:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozscreenshot 11:32:56 INFO - Running setup.py install for moztest 11:32:56 INFO - Running setup.py install for mozversion 11:32:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:56 INFO - Cleaning up... 11:32:56 INFO - Return code: 0 11:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:56 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:32:56 INFO - Using env: {'DISPLAY': ':0', 11:32:56 INFO - 'HOME': '/home/cltbld', 11:32:56 INFO - 'LANG': 'en_US.UTF-8', 11:32:56 INFO - 'LANGUAGE': 'en_US:en', 11:32:56 INFO - 'LOGNAME': 'cltbld', 11:32:56 INFO - 'MAIL': '/var/mail/cltbld', 11:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:56 INFO - 'MOZ_NO_REMOTE': '1', 11:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:56 INFO - 'NO_EM_RESTART': '1', 11:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:56 INFO - 'PWD': '/builds/slave/test', 11:32:56 INFO - 'SHELL': '/bin/bash', 11:32:56 INFO - 'SHLVL': '1', 11:32:56 INFO - 'TERM': 'linux', 11:32:56 INFO - 'TMOUT': '86400', 11:32:56 INFO - 'USER': 'cltbld', 11:32:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:56 INFO - '_': '/tools/buildbot/bin/python'} 11:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:56 INFO - Running setup.py (path:/tmp/pip-cHzuYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:56 INFO - Running setup.py (path:/tmp/pip-VbLCpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:57 INFO - Running setup.py (path:/tmp/pip-cvzDC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:57 INFO - Running setup.py (path:/tmp/pip-BRgUeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:57 INFO - Running setup.py (path:/tmp/pip-CvWM_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:57 INFO - Running setup.py (path:/tmp/pip-vm84MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:57 INFO - Running setup.py (path:/tmp/pip-ty36zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:57 INFO - Running setup.py (path:/tmp/pip-h6i34q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:57 INFO - Running setup.py (path:/tmp/pip-UFUMxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:57 INFO - Running setup.py (path:/tmp/pip-gQ3R4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:57 INFO - Running setup.py (path:/tmp/pip-KPguR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:57 INFO - Running setup.py (path:/tmp/pip-ZIbR5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:57 INFO - Running setup.py (path:/tmp/pip-NSN3m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:57 INFO - Running setup.py (path:/tmp/pip-lk__ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:57 INFO - Running setup.py (path:/tmp/pip-xIR6aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:57 INFO - Running setup.py (path:/tmp/pip-15aIJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:58 INFO - Running setup.py (path:/tmp/pip-f4MwpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:59 INFO - Downloading blessings-1.6.tar.gz 11:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:33:00 INFO - Installing collected packages: blessings 11:33:00 INFO - Running setup.py install for blessings 11:33:00 INFO - Successfully installed blessings 11:33:00 INFO - Cleaning up... 11:33:00 INFO - Return code: 0 11:33:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:00 INFO - Reading from file tmpfile_stdout 11:33:00 INFO - Current package versions: 11:33:00 INFO - argparse == 1.2.1 11:33:00 INFO - blessings == 1.6 11:33:00 INFO - blobuploader == 1.2.4 11:33:00 INFO - docopt == 0.6.1 11:33:00 INFO - manifestparser == 1.1 11:33:00 INFO - mozInstall == 1.12 11:33:00 INFO - mozcrash == 0.17 11:33:00 INFO - mozdebug == 0.1 11:33:00 INFO - mozdevice == 0.48 11:33:00 INFO - mozfile == 1.2 11:33:00 INFO - mozhttpd == 0.7 11:33:00 INFO - mozinfo == 0.9 11:33:00 INFO - mozleak == 0.1 11:33:00 INFO - mozlog == 3.1 11:33:00 INFO - moznetwork == 0.27 11:33:00 INFO - mozprocess == 0.22 11:33:00 INFO - mozprofile == 0.28 11:33:00 INFO - mozrunner == 6.11 11:33:00 INFO - mozscreenshot == 0.1 11:33:00 INFO - mozsystemmonitor == 0.0 11:33:00 INFO - moztest == 0.7 11:33:00 INFO - mozversion == 1.4 11:33:00 INFO - psutil == 3.1.1 11:33:00 INFO - requests == 1.2.3 11:33:00 INFO - wsgiref == 0.1.2 11:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:00 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:33:00 INFO - Using env: {'DISPLAY': ':0', 11:33:00 INFO - 'HOME': '/home/cltbld', 11:33:00 INFO - 'LANG': 'en_US.UTF-8', 11:33:00 INFO - 'LANGUAGE': 'en_US:en', 11:33:00 INFO - 'LOGNAME': 'cltbld', 11:33:00 INFO - 'MAIL': '/var/mail/cltbld', 11:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:00 INFO - 'MOZ_NO_REMOTE': '1', 11:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:00 INFO - 'NO_EM_RESTART': '1', 11:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:00 INFO - 'PWD': '/builds/slave/test', 11:33:00 INFO - 'SHELL': '/bin/bash', 11:33:00 INFO - 'SHLVL': '1', 11:33:00 INFO - 'TERM': 'linux', 11:33:00 INFO - 'TMOUT': '86400', 11:33:00 INFO - 'USER': 'cltbld', 11:33:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:00 INFO - '_': '/tools/buildbot/bin/python'} 11:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:33:00 INFO - Cleaning up... 11:33:00 INFO - Return code: 0 11:33:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:00 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:33:00 INFO - Using env: {'DISPLAY': ':0', 11:33:00 INFO - 'HOME': '/home/cltbld', 11:33:00 INFO - 'LANG': 'en_US.UTF-8', 11:33:00 INFO - 'LANGUAGE': 'en_US:en', 11:33:00 INFO - 'LOGNAME': 'cltbld', 11:33:00 INFO - 'MAIL': '/var/mail/cltbld', 11:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:00 INFO - 'MOZ_NO_REMOTE': '1', 11:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:00 INFO - 'NO_EM_RESTART': '1', 11:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:00 INFO - 'PWD': '/builds/slave/test', 11:33:00 INFO - 'SHELL': '/bin/bash', 11:33:00 INFO - 'SHLVL': '1', 11:33:00 INFO - 'TERM': 'linux', 11:33:00 INFO - 'TMOUT': '86400', 11:33:00 INFO - 'USER': 'cltbld', 11:33:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:00 INFO - '_': '/tools/buildbot/bin/python'} 11:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:00 INFO - Downloading/unpacking jsonschema 11:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:33:03 INFO - Downloading/unpacking functools32 (from jsonschema) 11:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:33:03 INFO - warning: no files found matching '*.txt' 11:33:03 INFO - no previously-included directories found matching 'build' 11:33:03 INFO - no previously-included directories found matching 'dist' 11:33:03 INFO - no previously-included directories found matching '.git*' 11:33:03 INFO - Installing collected packages: jsonschema, functools32 11:33:03 INFO - Running setup.py install for functools32 11:33:03 INFO - warning: no files found matching '*.txt' 11:33:03 INFO - no previously-included directories found matching 'build' 11:33:03 INFO - no previously-included directories found matching 'dist' 11:33:03 INFO - no previously-included directories found matching '.git*' 11:33:03 INFO - Successfully installed jsonschema functools32 11:33:03 INFO - Cleaning up... 11:33:03 INFO - Return code: 0 11:33:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:03 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 0x7fb0b1a6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:33:03 INFO - Using env: {'DISPLAY': ':0', 11:33:03 INFO - 'HOME': '/home/cltbld', 11:33:03 INFO - 'LANG': 'en_US.UTF-8', 11:33:03 INFO - 'LANGUAGE': 'en_US:en', 11:33:03 INFO - 'LOGNAME': 'cltbld', 11:33:03 INFO - 'MAIL': '/var/mail/cltbld', 11:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:03 INFO - 'MOZ_NO_REMOTE': '1', 11:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:03 INFO - 'NO_EM_RESTART': '1', 11:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:03 INFO - 'PWD': '/builds/slave/test', 11:33:03 INFO - 'SHELL': '/bin/bash', 11:33:03 INFO - 'SHLVL': '1', 11:33:03 INFO - 'TERM': 'linux', 11:33:03 INFO - 'TMOUT': '86400', 11:33:03 INFO - 'USER': 'cltbld', 11:33:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:03 INFO - '_': '/tools/buildbot/bin/python'} 11:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:03 INFO - Downloading/unpacking flake8 11:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:33:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:33:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:33:06 INFO - no previously-included directories found matching 'docs/_build' 11:33:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:33:06 INFO - Running setup.py install for pep8 11:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:33:06 INFO - no previously-included directories found matching 'docs/_build' 11:33:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:33:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:33:06 INFO - Cleaning up... 11:33:06 INFO - Return code: 0 11:33:06 INFO - Running post-action listener: _resource_record_post_action 11:33:06 INFO - Running post-action listener: _start_resource_monitoring 11:33:06 INFO - Starting resource monitoring. 11:33:06 INFO - ##### 11:33:06 INFO - ##### Running install step. 11:33:06 INFO - ##### 11:33:06 INFO - Running pre-action listener: _resource_record_pre_action 11:33:06 INFO - Running main action method: install 11:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:06 INFO - Reading from file tmpfile_stdout 11:33:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:33:06 INFO - Reading from file tmpfile_stdout 11:33:06 INFO - Output received: 11:33:06 INFO - Usage: mozinstall [options] installer 11:33:06 INFO - Options: 11:33:06 INFO - -h, --help show this help message and exit 11:33:06 INFO - -d DEST, --destination=DEST 11:33:06 INFO - Directory to install application into. [default: 11:33:06 INFO - "/builds/slave/test"] 11:33:06 INFO - --app=APP Application being installed. [default: firefox] 11:33:06 INFO - mkdir: /builds/slave/test/build/application 11:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:33:22 INFO - Reading from file tmpfile_stdout 11:33:22 INFO - Output received: 11:33:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:33:22 INFO - Running post-action listener: _resource_record_post_action 11:33:22 INFO - ##### 11:33:22 INFO - ##### Running run-tests step. 11:33:22 INFO - ##### 11:33:22 INFO - Running pre-action listener: _resource_record_pre_action 11:33:22 INFO - Running main action method: run_tests 11:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:33:22 INFO - Python 2.7.3 11:33:22 INFO - Return code: 0 11:33:22 INFO - grabbing minidump binary from tooltool 11:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:22 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 0x21ae410>, '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 0x21af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21af7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:33:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:33:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:33:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:33:22 INFO - Return code: 0 11:33:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:33:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:33:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:33:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:33:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:33:23 INFO - Return code: 0 11:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:33:23 INFO - Using env: {'DISPLAY': ':0', 11:33:23 INFO - 'HOME': '/home/cltbld', 11:33:23 INFO - 'LANG': 'en_US.UTF-8', 11:33:23 INFO - 'LANGUAGE': 'en_US:en', 11:33:23 INFO - 'LOGNAME': 'cltbld', 11:33:23 INFO - 'MAIL': '/var/mail/cltbld', 11:33:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:33:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:23 INFO - 'MOZ_NO_REMOTE': '1', 11:33:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:23 INFO - 'NO_EM_RESTART': '1', 11:33:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:23 INFO - 'PWD': '/builds/slave/test', 11:33:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:33:23 INFO - 'SHELL': '/bin/bash', 11:33:23 INFO - 'SHLVL': '1', 11:33:23 INFO - 'TERM': 'linux', 11:33:23 INFO - 'TMOUT': '86400', 11:33:23 INFO - 'USER': 'cltbld', 11:33:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801', 11:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:23 INFO - '_': '/tools/buildbot/bin/python'} 11:33:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:33:23 INFO - mozversion application_buildid: 20160421110016 11:33:23 INFO - mozversion application_changeset: fed6d478bf3d7cc80fbcf975361a2e2bc8e4ed30 11:33:23 INFO - mozversion application_display_name: Nightly 11:33:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:33:23 INFO - mozversion application_name: Firefox 11:33:23 INFO - mozversion application_remotingname: firefox 11:33:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:33:23 INFO - mozversion application_vendor: Mozilla 11:33:23 INFO - mozversion application_version: 48.0a1 11:33:23 INFO - mozversion platform_buildid: 20160421110016 11:33:23 INFO - mozversion platform_changeset: fed6d478bf3d7cc80fbcf975361a2e2bc8e4ed30 11:33:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:33:23 INFO - mozversion platform_version: 48.0a1 11:33:23 INFO - using testdate: 1461263603 11:33:23 INFO - actual date: 1461263603 11:33:23 INFO - starting webserver on 'localhost:48581' 11:33:23 INFO - SUITE-START | Running 2 tests 11:33:23 INFO - TEST-START | dromaeo_css 11:33:23 INFO - operating with platform_type : linux_ 11:33:23 INFO - Initialising browser for dromaeo_css test... 11:33:23 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvBE_yF/profile http://localhost:48581/getInfo.html) 11:33:29 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 11:33:29 INFO - PROCESS | 3340 | colorDepth:24 11:33:29 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 11:33:29 INFO - PROCESS | 3340 | __metrics 11:33:30 ERROR - PROCESS | 3340 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:33:31 INFO - TEST-INFO | 3340: exit 0 11:33:31 INFO - Browser initialized. 11:33:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:33:31 INFO - TEST-INFO | started process 3424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvBE_yF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:43 INFO - PROCESS | 3424 | RSS: Main: 155545600 11:33:43 INFO - PROCESS | 3424 | 11:34:35 INFO - PROCESS | 3424 | 1461263675253 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:36:46 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48581/tests/dromaeo/cssquery-ext.html) 11:36:48 INFO - PROCESS | 3424 | RSS: Main: 270327808 11:36:48 INFO - PROCESS | 3424 | 11:39:50 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-ext.html (next: http://localhost:48581/tests/dromaeo/cssquery-jquery.html) 11:39:51 INFO - PROCESS | 3424 | RSS: Main: 247357440 11:39:51 INFO - PROCESS | 3424 | 11:42:53 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48581/tests/dromaeo/cssquery-mootools.html) 11:42:54 INFO - PROCESS | 3424 | RSS: Main: 242012160 11:42:54 INFO - PROCESS | 3424 | 11:45:56 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48581/tests/dromaeo/cssquery-prototype.html) 11:45:56 INFO - PROCESS | 3424 | RSS: Main: 237334528 11:45:56 INFO - PROCESS | 3424 | 11:48:59 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48581/tests/dromaeo/cssquery-yui.html) 11:49:00 INFO - PROCESS | 3424 | RSS: Main: 219738112 11:49:00 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-yui.html (next: http://localhost:48581/tests/dromaeo/cssquery-dojo.html) 11:52:03 INFO - PROCESS | 3424 | RSS: Main: 290426880 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | __start_tp_report 11:52:03 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 11:52:03 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 11:52:03 INFO - PROCESS | 3424 | |i|pagename|runs| 11:52:03 INFO - PROCESS | 3424 | |0;dojo.html;2617.1494264364082;2679.544477438835;2685.9731402685966;2695.6360891279683;2716.6875809281937;4498.820047198116;4575.084983003404;4581.289900065487;4592.035672508773;4604.631629469643;4598.425196850394;4607.17070927233;4643.815826964119;4690.202665546857;4713.78787954542;4184.30958891784;4199.66402687785;4201.117765269297;4246.193223287565;4401.3397990301555;4353.238183317922;4357.891052723676;4368.868933931971;4373.803178856959;4410.448693913261;4162.812673429673;4249.702520823544;4261.978690106561;4304.354346847967;4342.023044814891;4264.019275566637;4291.91416171678;4332.350147477903;4332.718373305725;4373.978130109361;4233.386159006957;4280.400743895857;4284.978575107105;4288.056627541936;4324.22164010478;4418.5581441855875;4551.613112885409;4557.680962332638;4559.17934771741;4618.422697162855;4899.436564795059;4925.950740492585;4928.975355123237;4929.580985616227;4968.552830245295;4914.827981020647;4951.059298733265;4952.108620448318;4959.2809042688605;5005.349304590416;4530.954690453119;4638.11875743611;4644.930326045112;4716.127516409475;4739;5082.390113186441;5091.0581542414775;5096.847094587169;5125.923111153335;5176.5858731301405;4920.237363208708;4937.580305674058;4942.4316203637045;4951.5048495150195;4971.975140124277;4819.6867203631655;4937.654364194472;4975.651704380731;4986.850394488171;5000.324956130876;4848.7090774553635;4859.514048595112;4860.781264843091;4872.634552408584;4914.336564563738;4841.3222148899185;4841.95158048422;4859.052484765508;4859.1496488114435;4885.8045678173185;4061.7156799023783;4178.540360560336;4259.765712885821;4264.829406823692;4265.7440553566885;3692.2615476904725;3695.260947810395;3699.2416554606243;3725.3294407006997;3741.494898188764;4242.681798865097;4248.830046798155;4255.787210639455;4257.212415703043;4295;4869.050535145683;4882.267659851051;4931.753412329369;4951.975240123848;4960.379952505937;4187;4191.7484950903045;4200.7479551227025;4208.074223670787;4218.915621687549;4445.355423463579;4447.221736196153;4456;4489.9775501122285;4495.078508905666;4513.413256276663;4640.396748422683;4680.438347398334;4714.292856071616;4718.929216061693;4891.926621100615;4892.657513973988;4896.706197628154;4905.877353066202;4963.156263435297;4520.095980803787;4606.124836281096;4610.631149507964;4617.58441740245;4665.906681866411;4850.417949846041;4885.462599114024;4897.583705385082;4929.211326187793;4934.432540257772;4902.044101400193;4931.9753401232765;4934.210526315772;4937.572070460098;4980.377452818398;4683.508231635766;4733.290006499053;4747.406574178228;4795.472498025145;4833.250846118857;4765.642576806684;4786.928196076992;4797.784099715452;4811.49479304668;4843.39457567804;4684.281413405122;4688.718676879398;4710.26990816424;4721.976390118028;4780.354652121919;4758.2386818108935;4876.561109500162;4878.5609295162185;4878.878028049327;4966.950330496648;4647.674662773574;4741.146593613183;4757.7621118943225;4781.330613714013;4795.760211989317 11:52:03 INFO - PROCESS | 3424 | |1;ext.html;545.0853082626251;578.7569220927207;585.8681796595765;601.4767152577257;604.0787798607126;25974.61038084428;26516.73483265167;26525;26564.335891602695;33258.84041016106;36142;36618.267634647294;36777.632223677756;36783.44824827623;36819.26361472776;7672.271134242252;7808.0630324361155;7857.960710196441;7862.095858976234;7867.1739467355965;7370.189279179286;9557.378770379937;9805.460699661517;9830.803383932318;9840.704778856645;9901.257405694565;9921.751956201117;10048.849267260997;10055.547500362502;10057.748556286078;9784.755381115494;9931.262029144871;9937.65218217359;9940.5029748513;9947.60209591619;9741.561629726679;9839.262055345805;9857.90142098577;9864.829737457749;10073.345232559861;28611;29401.41197176066;29439.852800736073;35785.642143578494;36114.27771444556;2343.8359314847967;2632.223494069235;2717.605947137674;3131.4206871728575;3199.5520627112223;26240.475190496276;29257.41485170306;30079.69920300791;30745.846270768503;30976.845115774504;3492.3713731528314;3528.1003344147334;3536.8585256589704;3578.4632305154437;3658.9634103659155;229337.62617299057;305362;313495;314206.428967856;314506;48669.75665121723;48888.26667599989;49136;49152.50847491551;49157.50842491529;58113.128303075486;58258;58320.70839645775;58377.70811146002;58392;13384.263865487297;13481.797773033413;13543.661408464866;13559.728805424034;13668;9855.507224638739;9931.106200441995;9939.80120397588;9987.101160895409;10025.448600327052;19093.618127637368;19414.611707765765;19425.580219496715;19455.660236279575;19463.8053619462;7310.3448275862065;7456.627168641547;7535.284148005931;7602.695892164252;7675;970.0396607358664;970.84466485362;980.8871979722423;1022.4070039377143;1034.1726618705006;27638.585421218297;27663.44673106567;27899.581506277016;28358;28546.858125675157;969.4280374579032;991.1030517381781;1018.1752780248023;1033.9121174700235;1076.4133547216786;14260.714785704227;14909;15015.399384024735;15219.315130819139;15316.15761133126;345286;347480;351398;351521;352573;46501.767491162325;47101.528984709716;47309.29036064462;47340.763296183984;47369.763151184714;1122.3826895207767;1171.0807016492183;1275.6810797300675;1280.564608033273;1286.0804524764837;25258;26569.33576660599;27144.1856744298;27629.309267267676;27680;37965.81017094897;38612.80693596514;38622;38623;38697.80651096727;215112;219641;219948;221258;222007;31750.682493174772;31894.840525797223;32913.506297406035;32917;32948.50577241295;29293.121206363845;35547.28905421825;35612.50436256648;36078.27843443169;36104.819475902455;29748.256293591967;31514.527282091247;31998.840005799822;32712.83643581767;34653.65346346605;33657;33853.32293354168;34042.8297858519;34125.48811767875;34467.65532344745;33105.66894331026;33675.326493470486;33993.320133596695;34035.82982085173;34068.488972664934;30102.548461773527;30689.846550767103;30730.692693073677;30975.535366969063;31009.224769380042;23328.300150995496;23599.764002359756;23896;24076.51846963016;24314.392140196636 11:52:03 INFO - PROCESS | 3424 | |2;jquery.html;361.1873285108505;364.3496358999187;370.4165938646631;372.83408883047036;382.57343062485336;16147.999999999985;16404;16730.330786768514;16753.581160470963;16781.077040762753;14802.925985370059;16045.83954160458;16171.757423638655;16201.675966480692;16206.837931620681;4978.651494395403;5185.222216667511;5209.947900520984;5222.712750798704;5247.711375874325;3591.120175556979;5086.41506226785;5614.214010038598;5906.527477801766;5958.8808223835495;5845.269341332333;5846.736896839631;5871.412858714137;5875.588708790387;5882.529397648199;5764.365919748824;5843.328017278025;5845.415458454163;5846.941530584725;5850.73671684773;3292.3415316936707;4877.487863774288;5136.306598609177;5141.922871156936;5163.664361816507;19291.51771205717;19410.514737131543;19460;19770.40688779339;20447.795522044737;1918.2614693343023;2007.247282269149;2271.216430331533;2286.5998450271304;2289.6908917296287;12985.22088674673;13092.86907130926;13214.471421143142;13363.06458547902;13768.724625507533;1718.6562687462558;1797.2810875649714;1866.0762922353385;1907.437305994721;1916.3101283537915;67698.66150669265;68819.65590172067;69696.65151674209;70171.64914175447;70439.29560704378;9076.546172691338;9151.862722059175;9566.9043309566;9832.606695732233;10203.183745300357;12981.935090324489;13169.144005639602;13195.538156164681;13198.47206111764;13216.867831321755;6823.829404264834;6872.728545219151;6972.616506092214;7028.578285302899;7134.1795693495915;6640.0703901453835;6656.2345330287635;6682.665866706742;6749.42629876466;6785.728570857111;5916.461719952843;6005.819825405245;6043.909341359883;6067.7876274331065;6099.993501072273;1613.9757903631455;1677.8070521889895;1694.466243133409;1713.4431309824108;1769.186174359783;927.0914503786328;956.2588993529931;964.1997142371814;974.0794948773341;996.7906739584623;16565.503034908972;17015.23431445588;17019.48941531756;17418.12909354527;17681.764183246793;885.9158379953894;909.1635695160468;967.1150896929372;1000.4097582426404;1030.9381437113798;9733.318667693193;9870.25973052024;10071.295009349275;10088.991100889853;10253;382500;390776;403036;405722;405778;68377.31622683808;68465.3153468469;68583;69510;69850;952.9047095290415;969.195567678839;980.632262901412;984.7045886234101;988.7429268390271;15114.09315441077;15515.146666933428;15523.301451434938;15702.450414235447;15795.289211985719;31068.533971989986;31785.682143178274;32019;32988.50517242291;33184.336313274085;40504.392434112924;43007.49473768403;43511.78244108886;43961.34057989197;44141;7632.38940884739;7646.923530764621;7778.455508114378;7933.286004259644;7968.601569921597;12044.638660840188;12131.180322951628;12207.328596927255;12230.327331996825;12444.440000200193;5825.0388685866355;6075.969620151871;10731.678049658523;10794.406307653155;10891.346519208873;9305.720828375159;10256.641017564349;10398.064174224357;10510.211734120125;10612.469376530988;9967.651132210338;10016.449095299828;10323.380597164194;10414;10666.093382062301;7842.058952925686;8026.638801254075;8035.638396272065;8104.473209241381;8175.223353781381;9739.220862330854;10198.388096714221;10358.585656573652;10473.371597704163;10608.681739547827 11:52:03 INFO - PROCESS | 3424 | |3;mootools.html;1276.7382686549258;1373.443755279112;1430.4707258314422;1533.3023474319186;1746.9825301746978;6283.780067697631;7262.963685181573;7478.32695057444;7484.214157513465;7484.476086673935;7272.890906636405;7436.739714110007;7444.255574442553;7451.329380355767;7460.32857042866;1859.888406695596;2091.4666759976185;2142.689310050042;2147.38799442159;2169.8264138868853;2139.037433155079;2139.208492857645;2145.377840426282;2155.7089792877996;2156.7196264485597;2148.4091874734495;2164.9025793839237;2165.404513758713;2167.1331467413;2167.2739632223224;1900.4108726294824;2071.399294204679;2110.2930518276394;2111.7043613894066;2112.461322362803;2053.404512691318;2057.146284292017;2057.9382618521317;2060.536379314657;2060.9381718548316;7060.435165186773;7091.432685385157;7103.218645948941;7103.928960710378;7119.466040046966;4188.204241194163;4267.829286828523;4330.761808100553;4343;4386.846460373904;2830.985845070782;2861.527847905093;2882.2506148401358;2884.1635925581554;2933.3399985003416;960.6109525642127;971.9271054670928;976.7997560500152;982.0326977926736;998.5606333213362;10015.69952901414;10021.148202402732;10067.144292735125;10078.244131690079;10082.747931301703;3935.4883865097354;3986;4150.688698347636;4165.520965088993;4218.346156345771;8616.39685222041;8652.740417787476;8654.78363040929;8656.09111043344;8666.86999695005;3771.7171212159196;4546.795394207269;4557.407537020166;4583.54164583539;4584.289435137559;3931.8427262909163;3999.7600143991453;4002.579729128458;4030.2946984277633;4038.63652271297;3393.406153923103;3466.9133271667906;3500.43992961125;3516.367053930317;3551.076720052753;1146;1161.465725766157;1163.6450882480756;1163.976720465586;1173.7711146326556;851.4423052900237;859.4928991894687;870.216804875617;898.2095755734912;915.2860768600502;5241.0566098101945;5248.7900483980975;5298.125809241432;5326.280952071421;5439;880.3925291548811;892.2549671024638;893.5621545442687;927.2628260532757;932.612965619274;3557.9822100889846;3577.874774382884;3601.099725068733;3654.2326111516877;3696.611855755107;8343.16568343173;8630.82738345242;8669.91330086691;8729.825403491895;8731.60707768152;8670.696525621574;8776.385653004356;8818.426802257833;8869.911300886908;8887;6794.0827988221945;6952.756653517103;7024.1571011478945;7042.295770423019;7059;5333.679979201105;5348.224507446476;5353.625246232882;5357.598180136428;5530.695811730394;8407;8467.703630373153;8564.785880352792;8601.655933762579;8667.306615470621;8595.871061934202;8653.091425400242;8710.128987101492;8712.172343627346;8821.117888211384;6270.874582508415;6273.811785646438;6391.424771770563;6476.384743449365;6498.902516462352;7219.422446204396;7220.89168662481;7248.166460857069;7254.818629534304;7261.818454538678;6499.415052645285;6571.408573228432;6622.801315960529;6801.9319806801295;6827.863442731217;6297.1813664223355;6416.13382193398;6519.08732777402;6619.569727967667;6643.435307998874;6040.577159598962;6086.482648974709;6139.324674285915;6184.072389141485;6313.715882785377;4360.7601581913295;4470.150671372428;4600.3329517219145;4607.539246075366;4639.234526303258;4378.496472905529;4484.080763443421;4636.675432719677;4705.670603057753;4751.952480475289 11:52:03 INFO - PROCESS | 3424 | |4;prototype.html;291.6383684231552;304.1574837699572;304.7836036414146;309.60370725471404;310.55125343878103;4876.561109500144;5001.749912504374;5033.446320904697;5042.873928151798;5043.84868453947;4846.806127754894;5058.721770302632;5063.9493605063935;5069.290299358093;5071.290019397287;3974.2250261198933;3974.562003866656;3980.9402858957137;3985.2228815381013;3994.6604538614106;3757.3988161894104;3796.5762838935398;3959.821808018646;3983.302921988655;3986.3621820508724;3927.9803600981954;3937.2519221347998;3939.443919651736;3944.349182384903;3949.8617548385814;3889.9027524311978;3900.609939006105;3910.1593157470998;3923.431102490123;3949.19041596472;3476.4263896457055;3481.582210134775;3482.564679415073;3483.6342184070813;3485.930281394383;4611.930821037688;4858.587020103296;4865.075635629254;4883.095592718842;4901.289313049623;4412.139632771611;4417.602415782595;4449.710768800018;4453;4454.13144436835;5312.379724184122;5341.679499230058;5350.35795704514;5357.116075847481;5368.409474957752;3524.1189702574356;3714.461403096536;3715.1640880801874;3729.067733066733;3745.756525825813;5429.267048948381;5522.116461366162;5561.499465048125;5562.887422515513;5564.8330550083565;3786.3184626767447;3800.2969450651717;3817.828197731109;3818.675412589961;3834.482344883461;3637.636236376341;3846.6728978502933;3860.3630400983525;3874.1476875087437;3879.592642772525;4363.781810909441;4393.209222339946;4404.889877753082;4410.294352903584;4411.889702757392;5306.699858534606;5311.48622642545;5319.787208511693;5324.254604355393;5334.17320315344;1271.8664540223328;1294.7734146524508;1328.216352352117;1335.4457899971596;1337.6522104252965;876.4215617692292;879.4371602174614;902;903.1871315815819;914.5107367558325;4599.505160822746;4613.515580864028;4620.607248383858;4622.14490319292;4626.791794369262;5387.488188622075;5432.103702889058;5436.891262174734;5437.401885792559;5453.64551304164;4467.776611169428;4597.839075632337;4606;4608.3778689876435;4611.538846115429;2881.236472334833;2890.682024977251;2894.3343031102963;2895.0880472651047;2895.5077636801793;5044.9495505045215;5091.8981620367385;5108.56577190943;5116.641835071509;5139.691618502827;5262.289590905255;5534.833954981357;5550.639208451437;5559.555235581144;5633.352164501053;5121.539061484485;5123.590112790967;5144.9742751286;5158.349328214935;5162.225666150108;5446.673199608036;5453.700046497481;5470.72646367688;5477.782107777069;5478.808241711521;5271.130263506632;5370.704611246419;5377.139657654757;5414.29614150158;5421.539169170507;5109.156989096906;5118;5147.382314122329;5162.819301324435;5165.405978312392;3742.326381251401;3766.9058273543383;3773.2830762155104;3776.244751049746;3781.903248058032;5226.686398816083;5328.120860058047;5427.375851777097;5442.755076021668;5458.590605704668;5162.8193013245855;5266.73666316675;5353.330833645794;5365.517103460707;5366;5321.574274058144;5333.333333333333;5348.545373643284;5356.196570514454;5360.839174824761;5128.769205385841;5257.161132988296;5260.631755777059;5261.237120617412;5281.910082601721;5358.169483730028;5366.7048312343195;5386;5386.5152136307925;5390.595705322195;5244.606654501004;5245.265662807134;5264.684118952875;5268.473152684701;5272.130098533699 11:52:03 INFO - PROCESS | 3424 | |5;yui.html;682.6416131530946;689.4484412470023;693.6809067828799;748.7080038784873;781.2148790465579;11375.488103035363;12150.635480935563;12427.254364738123;12499.18755280906;12718.872811271896;13390.66523336917;13428.865711342884;13494;13581.728365432686;13611.251381174032;636.4049613611288;781.5076501803884;810.0441479054698;817.6770175780563;819.1767273889733;817.9672813087469;823.1644880446352;823.6087858267335;824.4970567953544;824.7360844529753;855.6962278391175;856.3919617071887;858.9570521473933;861.1044513705739;862.094800459515;669.2571245917028;810.4812919731377;853.6884037326394;854.3208149521115;856.015582080606;625.1154616218046;625.4308579192958;625.7590827531387;625.7872323410016;625.8685676008043;11408.486618102123;11459.197856150073;11466.369349685763;11468.082553395709;11481.598144065001;12366.319852408114;12633.684157896034;12832.743345133138;12919.67700807478;13064.934675326658;9928.602855885756;10167.694969150938;10181.45865998228;10330.7417314567;10366.844497332546;4276.2089013532595;4285.571442855689;4301.870943871689;4330.805113769888;4475.709078909893;45789.31316030262;46911.765441172574;46987;47021.29468058016;47131.764341178416;9932.404055756677;10086.29395942277;10106.646267380607;10247.897521024694;10257.17942564593;18091.909540452212;18095.72856407155;18103.818961810477;18106.818931810776;18120.456386308433;6931.1682598088555;7023.508354415142;7024.473164512579;7163.6060016699585;7207.783766487014;3878.4764056852528;3915.1190982029384;3919.8040097994985;3920.9607903921165;3956.050547868491;2907.9854600727285;2947.3073827650487;2961.4669359515065;2968.5250359942306;2970.12381347503;513.7559659161943;514.5831876180306;517.9792808287701;518.1036806325079;524.3692117514527;614.5237440983274;624.1168746224133;645.3997782062632;648.5362965479704;654.8919428294278;7899.210078992055;7954.880676789853;8013.559254240956;8195.7951051223;8408.285295749929;604.072748331318;656.1309090188315;673.1686367336335;676.972921083161;678.375894177358;3861.169848482534;3972.940405893856;3994.3409337458993;4003.779792111462;4027.496562929634;50595;51598.48401515937;51633.48366516362;51640.225396619084;51769;42858.35712464315;43510.34734478922;43763;44030;44112.55887441149;41567.713775742624;41943.370849437284;42444;42808.3578746319;42953;7480.962595187207;7770.898140510449;7775;7783.299503044753;7969.840603187788;27927.441451170456;28159.296017599725;28267.57598635981;29423.55864661989;29539.26151846135;34210.31579368449;35132.64867351396;37433.625663744104;37792.811035944644;37922.62077379191;9916.256280778825;10034.899651003396;10069.575588907896;10216.642417515352;10260.230482713678;10414.271001029856;10562.8415573768;10959.232853700165;11010.669679909295;11335.943320283346;8012.203033919712;10553.366797992145;11201.215914886207;11217.775644487228;11377.54489820431;10886.346819190874;11292.378919159524;11534.077273817906;11570.132240082195;11652.94173529127;9900.752481188028;10004;10107.898921010696;10321.329113607591;10384.584616615251;9452.95273523628;9855.31012829095;10012.84980725275;10036.247281454067;10174.796504070026;9217.893852737714;9580.568874400808;9616.95191524038;9692.224622030362;9699.17557007634 11:52:03 INFO - PROCESS | 3424 | __end_tp_report 11:52:03 INFO - PROCESS | 3424 | __start_cc_report 11:52:03 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,1099 11:52:03 INFO - PROCESS | 3424 | __end_cc_report 11:52:03 INFO - PROCESS | 3424 | __startTimestamp1461264723446__endTimestamp 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | ------- Summary: start ------- 11:52:03 INFO - PROCESS | 3424 | Number of tests: 6 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:4571.52 Median:4688.72 stddev:458.76 (9.8%) stddev-sans-first:433.79 11:52:03 INFO - PROCESS | 3424 | Values: 2617.1 2679.5 2686.0 2695.6 2716.7 4498.8 4575.1 4581.3 4592.0 4604.6 4598.4 4607.2 4643.8 4690.2 4713.8 4184.3 4199.7 4201.1 4246.2 4401.3 4353.2 4357.9 4368.9 4373.8 4410.4 4162.8 4249.7 4262.0 4304.4 4342.0 4264.0 4291.9 4332.4 4332.7 4374.0 4233.4 4280.4 4285.0 4288.1 4324.2 4418.6 4551.6 4557.7 4559.2 4618.4 4899.4 4926.0 4929.0 4929.6 4968.6 4914.8 4951.1 4952.1 4959.3 5005.3 4531.0 4638.1 4644.9 4716.1 4739.0 5082.4 5091.1 5096.8 5125.9 5176.6 4920.2 4937.6 4942.4 4951.5 4972.0 4819.7 4937.7 4975.7 4986.9 5000.3 4848.7 4859.5 4860.8 4872.6 4914.3 4841.3 4842.0 4859.1 4859.1 4885.8 4061.7 4178.5 4259.8 4264.8 4265.7 3692.3 3695.3 3699.2 3725.3 3741.5 4242.7 4248.8 4255.8 4257.2 4295.0 4869.1 4882.3 4931.8 4952.0 4960.4 4187.0 4191.7 4200.7 4208.1 4218.9 4445.4 4447.2 4456.0 4490.0 4495.1 4513.4 4640.4 4680.4 4714.3 4718.9 4891.9 4892.7 4896.7 4905.9 4963.2 4520.1 4606.1 4610.6 4617.6 4665.9 4850.4 4885.5 4897.6 4929.2 4934.4 4902.0 4932.0 4934.2 4937.6 4980.4 4683.5 4733.3 4747.4 4795.5 4833.3 4765.6 4786.9 4797.8 4811.5 4843.4 4684.3 4688.7 4710.3 4722.0 4780.4 4758.2 4876.6 4878.6 4878.9 4967.0 4647.7 4741.1 4757.8 4781.3 4795.8 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:43944.67 Median:33764.32 stddev:77108.22 (228.4%) stddev-sans-first:77255.68 11:52:03 INFO - PROCESS | 3424 | Values: 545.1 578.8 585.9 601.5 604.1 25974.6 26516.7 26525.0 26564.3 33258.8 36142.0 36618.3 36777.6 36783.4 36819.3 7672.3 7808.1 7858.0 7862.1 7867.2 7370.2 9557.4 9805.5 9830.8 9840.7 9901.3 9921.8 10048.8 10055.5 10057.7 9784.8 9931.3 9937.7 9940.5 9947.6 9741.6 9839.3 9857.9 9864.8 10073.3 28611.0 29401.4 29439.9 35785.6 36114.3 2343.8 2632.2 2717.6 3131.4 3199.6 26240.5 29257.4 30079.7 30745.8 30976.8 3492.4 3528.1 3536.9 3578.5 3659.0 229337.6 305362.0 313495.0 314206.4 314506.0 48669.8 48888.3 49136.0 49152.5 49157.5 58113.1 58258.0 58320.7 58377.7 58392.0 13384.3 13481.8 13543.7 13559.7 13668.0 9855.5 9931.1 9939.8 9987.1 10025.4 19093.6 19414.6 19425.6 19455.7 19463.8 7310.3 7456.6 7535.3 7602.7 7675.0 970.0 970.8 980.9 1022.4 1034.2 27638.6 27663.4 27899.6 28358.0 28546.9 969.4 991.1 1018.2 1033.9 1076.4 14260.7 14909.0 15015.4 15219.3 15316.2 345286.0 347480.0 351398.0 351521.0 352573.0 46501.8 47101.5 47309.3 47340.8 47369.8 1122.4 1171.1 1275.7 1280.6 1286.1 25258.0 26569.3 27144.2 27629.3 27680.0 37965.8 38612.8 38622.0 38623.0 38697.8 215112.0 219641.0 219948.0 221258.0 222007.0 31750.7 31894.8 32913.5 32917.0 32948.5 29293.1 35547.3 35612.5 36078.3 36104.8 29748.3 31514.5 31998.8 32712.8 34653.7 33657.0 33853.3 34042.8 34125.5 34467.7 33105.7 33675.3 33993.3 34035.8 34068.5 30102.5 30689.8 30730.7 30975.5 31009.2 23328.3 23599.8 23896.0 24076.5 24314.4 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:24029.60 Median:221770.20 stddev:65324.79 (29.5%) stddev-sans-first:65483.86 11:52:03 INFO - PROCESS | 3424 | Values: 361.2 364.3 370.4 372.8 382.6 16148.0 16404.0 16730.3 16753.6 16781.1 14802.9 16045.8 16171.8 16201.7 16206.8 4978.7 5185.2 5209.9 5222.7 5247.7 3591.1 5086.4 5614.2 5906.5 5958.9 5845.3 5846.7 5871.4 5875.6 5882.5 5764.4 5843.3 5845.4 5846.9 5850.7 3292.3 4877.5 5136.3 5141.9 5163.7 19291.5 19410.5 19460.0 19770.4 20447.8 1918.3 2007.2 2271.2 2286.6 2289.7 12985.2 13092.9 13214.5 13363.1 13768.7 1718.7 1797.3 1866.1 1907.4 1916.3 67698.7 68819.7 69696.7 70171.6 70439.3 9076.5 9151.9 9566.9 9832.6 10203.2 12981.9 13169.1 13195.5 13198.5 13216.9 6823.8 6872.7 6972.6 7028.6 7134.2 6640.1 6656.2 6682.7 6749.4 6785.7 5916.5 6005.8 6043.9 6067.8 6100.0 1614.0 1677.8 1694.5 1713.4 1769.2 927.1 956.3 964.2 974.1 996.8 16565.5 17015.2 17019.5 17418.1 17681.8 885.9 909.2 967.1 1000.4 1030.9 9733.3 9870.3 10071.3 10089.0 10253.0 382500.0 390776.0 403036.0 405722.0 405778.0 68377.3 68465.3 68583.0 69510.0 69850.0 952.9 969.2 980.6 984.7 988.7 15114.1 15515.1 15523.3 15702.5 15795.3 31068.5 31785.7 32019.0 32988.5 33184.3 40504.4 43007.5 43511.8 43961.3 44141.0 7632.4 7646.9 7778.5 7933.3 7968.6 12044.6 12131.2 12207.3 12230.3 12444.4 5825.0 6076.0 10731.7 10794.4 10891.3 9305.7 10256.6 10398.1 10510.2 10612.5 9967.7 10016.4 10323.4 10414.0 10666.1 7842.1 8026.6 8035.6 8104.5 8175.2 9739.2 10198.4 10358.6 10473.4 10608.7 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:4930.71 Median:5350.92 stddev:2675.91 (50.0%) stddev-sans-first:2669.32 11:52:03 INFO - PROCESS | 3424 | Values: 1276.7 1373.4 1430.5 1533.3 1747.0 6283.8 7263.0 7478.3 7484.2 7484.5 7272.9 7436.7 7444.3 7451.3 7460.3 1859.9 2091.5 2142.7 2147.4 2169.8 2139.0 2139.2 2145.4 2155.7 2156.7 2148.4 2164.9 2165.4 2167.1 2167.3 1900.4 2071.4 2110.3 2111.7 2112.5 2053.4 2057.1 2057.9 2060.5 2060.9 7060.4 7091.4 7103.2 7103.9 7119.5 4188.2 4267.8 4330.8 4343.0 4386.8 2831.0 2861.5 2882.3 2884.2 2933.3 960.6 971.9 976.8 982.0 998.6 10015.7 10021.1 10067.1 10078.2 10082.7 3935.5 3986.0 4150.7 4165.5 4218.3 8616.4 8652.7 8654.8 8656.1 8666.9 3771.7 4546.8 4557.4 4583.5 4584.3 3931.8 3999.8 4002.6 4030.3 4038.6 3393.4 3466.9 3500.4 3516.4 3551.1 1146.0 1161.5 1163.6 1164.0 1173.8 851.4 859.5 870.2 898.2 915.3 5241.1 5248.8 5298.1 5326.3 5439.0 880.4 892.3 893.6 927.3 932.6 3558.0 3577.9 3601.1 3654.2 3696.6 8343.2 8630.8 8669.9 8729.8 8731.6 8670.7 8776.4 8818.4 8869.9 8887.0 6794.1 6952.8 7024.2 7042.3 7059.0 5333.7 5348.2 5353.6 5357.6 5530.7 8407.0 8467.7 8564.8 8601.7 8667.3 8595.9 8653.1 8710.1 8712.2 8821.1 6270.9 6273.8 6391.4 6476.4 6498.9 7219.4 7220.9 7248.2 7254.8 7261.8 6499.4 6571.4 6622.8 6801.9 6827.9 6297.2 6416.1 6519.1 6619.6 6643.4 6040.6 6086.5 6139.3 6184.1 6313.7 4360.8 4470.2 4600.3 4607.5 4639.2 4378.5 4484.1 4636.7 4705.7 4752.0 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:4384.11 Median:5044.40 stddev:1286.92 (25.5%) stddev-sans-first:1253.34 11:52:03 INFO - PROCESS | 3424 | Values: 291.6 304.2 304.8 309.6 310.6 4876.6 5001.7 5033.4 5042.9 5043.8 4846.8 5058.7 5063.9 5069.3 5071.3 3974.2 3974.6 3980.9 3985.2 3994.7 3757.4 3796.6 3959.8 3983.3 3986.4 3928.0 3937.3 3939.4 3944.3 3949.9 3889.9 3900.6 3910.2 3923.4 3949.2 3476.4 3481.6 3482.6 3483.6 3485.9 4611.9 4858.6 4865.1 4883.1 4901.3 4412.1 4417.6 4449.7 4453.0 4454.1 5312.4 5341.7 5350.4 5357.1 5368.4 3524.1 3714.5 3715.2 3729.1 3745.8 5429.3 5522.1 5561.5 5562.9 5564.8 3786.3 3800.3 3817.8 3818.7 3834.5 3637.6 3846.7 3860.4 3874.1 3879.6 4363.8 4393.2 4404.9 4410.3 4411.9 5306.7 5311.5 5319.8 5324.3 5334.2 1271.9 1294.8 1328.2 1335.4 1337.7 876.4 879.4 902.0 903.2 914.5 4599.5 4613.5 4620.6 4622.1 4626.8 5387.5 5432.1 5436.9 5437.4 5453.6 4467.8 4597.8 4606.0 4608.4 4611.5 2881.2 2890.7 2894.3 2895.1 2895.5 5044.9 5091.9 5108.6 5116.6 5139.7 5262.3 5534.8 5550.6 5559.6 5633.4 5121.5 5123.6 5145.0 5158.3 5162.2 5446.7 5453.7 5470.7 5477.8 5478.8 5271.1 5370.7 5377.1 5414.3 5421.5 5109.2 5118.0 5147.4 5162.8 5165.4 3742.3 3766.9 3773.3 3776.2 3781.9 5226.7 5328.1 5427.4 5442.8 5458.6 5162.8 5266.7 5353.3 5365.5 5366.0 5321.6 5333.3 5348.5 5356.2 5360.8 5128.8 5257.2 5260.6 5261.2 5281.9 5358.2 5366.7 5386.0 5386.5 5390.6 5244.6 5245.3 5264.7 5268.5 5272.1 11:52:03 INFO - PROCESS | 3424 | 11:52:03 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:12630.56 Median:23627.44 stddev:14083.15 (59.6%) stddev-sans-first:14094.08 11:52:03 INFO - PROCESS | 3424 | Values: 682.6 689.4 693.7 748.7 781.2 11375.5 12150.6 12427.3 12499.2 12718.9 13390.7 13428.9 13494.0 13581.7 13611.3 636.4 781.5 810.0 817.7 819.2 818.0 823.2 823.6 824.5 824.7 855.7 856.4 859.0 861.1 862.1 669.3 810.5 853.7 854.3 856.0 625.1 625.4 625.8 625.8 625.9 11408.5 11459.2 11466.4 11468.1 11481.6 12366.3 12633.7 12832.7 12919.7 13064.9 9928.6 10167.7 10181.5 10330.7 10366.8 4276.2 4285.6 4301.9 4330.8 4475.7 45789.3 46911.8 46987.0 47021.3 47131.8 9932.4 10086.3 10106.6 10247.9 10257.2 18091.9 18095.7 18103.8 18106.8 18120.5 6931.2 7023.5 7024.5 7163.6 7207.8 3878.5 3915.1 3919.8 3921.0 3956.1 2908.0 2947.3 2961.5 2968.5 2970.1 513.8 514.6 518.0 518.1 524.4 614.5 624.1 645.4 648.5 654.9 7899.2 7954.9 8013.6 8195.8 8408.3 604.1 656.1 673.2 677.0 678.4 3861.2 3972.9 3994.3 4003.8 4027.5 50595.0 51598.5 51633.5 51640.2 51769.0 42858.4 43510.3 43763.0 44030.0 44112.6 41567.7 41943.4 42444.0 42808.4 42953.0 7481.0 7770.9 7775.0 7783.3 7969.8 27927.4 28159.3 28267.6 29423.6 29539.3 34210.3 35132.6 37433.6 37792.8 37922.6 9916.3 10034.9 10069.6 10216.6 10260.2 10414.3 10562.8 10959.2 11010.7 11335.9 8012.2 10553.4 11201.2 11217.8 11377.5 10886.3 11292.4 11534.1 11570.1 11652.9 9900.8 10004.0 10107.9 10321.3 10384.6 9453.0 9855.3 10012.8 10036.2 10174.8 9217.9 9580.6 9617.0 9692.2 9699.2 11:52:03 INFO - PROCESS | 3424 | -------- Summary: end -------- 11:52:03 INFO - PROCESS | 3424 | 11:52:04 INFO - TEST-INFO | 3424: exit 0 11:52:04 INFO - TEST-OK | dromaeo_css | took 1120218ms 11:52:04 INFO - TEST-START | kraken 11:52:04 INFO - operating with platform_type : linux_ 11:52:04 INFO - Initialising browser for kraken test... 11:52:04 INFO - TEST-INFO | started process 3599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpePTuOh/profile http://localhost:48581/getInfo.html) 11:52:08 INFO - PROCESS | 3599 | __metrics Screen width/height:1600/1200 11:52:08 INFO - PROCESS | 3599 | colorDepth:24 11:52:08 INFO - PROCESS | 3599 | Browser inner width/height: 1024/697 11:52:08 INFO - PROCESS | 3599 | __metrics 11:52:09 ERROR - PROCESS | 3599 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:52:10 INFO - TEST-INFO | 3599: exit 0 11:52:10 INFO - Browser initialized. 11:52:10 INFO - Running cycle 1/1 for kraken test... 11:52:10 INFO - TEST-INFO | started process 3682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpePTuOh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:22 INFO - PROCESS | 3682 | RSS: Main: 155578368 11:52:22 INFO - PROCESS | 3682 | 11:52:25 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-beat-detection) 11:52:26 INFO - PROCESS | 3682 | RSS: Main: 210391040 11:52:26 INFO - PROCESS | 3682 | 11:52:28 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-dft) 11:52:29 INFO - PROCESS | 3682 | RSS: Main: 195330048 11:52:29 INFO - PROCESS | 3682 | 11:52:32 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-fft) 11:52:33 INFO - PROCESS | 3682 | RSS: Main: 266403840 11:52:33 INFO - PROCESS | 3682 | 11:52:35 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-oscillator) 11:52:35 INFO - PROCESS | 3682 | RSS: Main: 174817280 11:52:35 INFO - PROCESS | 3682 | 11:52:38 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:52:38 INFO - PROCESS | 3682 | RSS: Main: 179236864 11:52:38 INFO - PROCESS | 3682 | 11:52:41 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-darkroom) 11:52:42 INFO - PROCESS | 3682 | RSS: Main: 215056384 11:52:42 INFO - PROCESS | 3682 | 11:52:46 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:46 INFO - PROCESS | 3682 | RSS: Main: 212672512 11:52:46 INFO - PROCESS | 3682 | 11:52:49 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48581/tests/kraken/driver.html?testName=json-parse-financial) 11:52:50 INFO - PROCESS | 3682 | RSS: Main: 214228992 11:52:50 INFO - PROCESS | 3682 | 11:52:51 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:52 INFO - PROCESS | 3682 | RSS: Main: 202031104 11:52:52 INFO - PROCESS | 3682 | 11:52:54 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:54 INFO - PROCESS | 3682 | RSS: Main: 205709312 11:52:54 INFO - PROCESS | 3682 | 11:52:56 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:57 INFO - PROCESS | 3682 | RSS: Main: 218456064 11:52:57 INFO - PROCESS | 3682 | 11:53:00 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:53:01 INFO - PROCESS | 3682 | RSS: Main: 225271808 11:53:01 INFO - PROCESS | 3682 | 11:53:04 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:53:04 INFO - PROCESS | 3682 | RSS: Main: 220823552 11:53:04 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48581/tests/kraken/driver.html?testName=ai-astar) 11:53:06 INFO - PROCESS | 3682 | RSS: Main: 284008448 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | __start_tp_report 11:53:06 INFO - PROCESS | 3682 | _x_x_mozilla_page_load 11:53:06 INFO - PROCESS | 3682 | _x_x_mozilla_page_load_details 11:53:06 INFO - PROCESS | 3682 | |i|pagename|runs| 11:53:06 INFO - PROCESS | 3682 | |0;ai-astar;112;112;110;114;116;115;103;112;112;113 11:53:06 INFO - PROCESS | 3682 | |1;audio-beat-detection;170;132;156;184;132;159;157;133;184;131 11:53:06 INFO - PROCESS | 3682 | |2;audio-dft;162;161;160;161;161;161;164;163;169;163 11:53:06 INFO - PROCESS | 3682 | |3;audio-fft;74;78;103;107;77;74;73;125;106;77 11:53:06 INFO - PROCESS | 3682 | |4;audio-oscillator;94;94;136;94;95;94;142;94;92;149 11:53:06 INFO - PROCESS | 3682 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;118;116 11:53:06 INFO - PROCESS | 3682 | |6;imaging-darkroom;147;146;146;145;147;145;147;146;146;146 11:53:06 INFO - PROCESS | 3682 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 11:53:06 INFO - PROCESS | 3682 | |8;json-parse-financial;64;64;64;65;64;65;65;82;64;61 11:53:06 INFO - PROCESS | 3682 | |9;json-stringify-tinderbox;64;64;64;65;65;64;64;63;64;64 11:53:06 INFO - PROCESS | 3682 | |10;stanford-crypto-aes;78;78;80;78;80;80;80;80;81;79 11:53:06 INFO - PROCESS | 3682 | |11;stanford-crypto-ccm;140;136;132;131;146;132;133;132;166;133 11:53:06 INFO - PROCESS | 3682 | |12;stanford-crypto-pbkdf2;175;175;181;180;178;184;175;173;175;180 11:53:06 INFO - PROCESS | 3682 | |13;stanford-crypto-sha256-iterative;74;76;73;71;70;71;74;75;73;70 11:53:06 INFO - PROCESS | 3682 | __end_tp_report 11:53:06 INFO - PROCESS | 3682 | __start_cc_report 11:53:06 INFO - PROCESS | 3682 | _x_x_mozilla_cycle_collect,1885 11:53:06 INFO - PROCESS | 3682 | __end_cc_report 11:53:06 INFO - PROCESS | 3682 | __startTimestamp1461264786688__endTimestamp 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | ------- Summary: start ------- 11:53:06 INFO - PROCESS | 3682 | Number of tests: 14 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:3.57 (3.2%) stddev-sans-first:3.79 11:53:06 INFO - PROCESS | 3682 | Values: 112.0 112.0 110.0 114.0 116.0 115.0 103.0 112.0 112.0 113.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:158.00 stddev:21.16 (13.4%) stddev-sans-first:21.62 11:53:06 INFO - PROCESS | 3682 | Values: 170.0 132.0 156.0 184.0 132.0 159.0 157.0 133.0 184.0 131.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.59 (1.6%) stddev-sans-first:2.74 11:53:06 INFO - PROCESS | 3682 | Values: 162.0 161.0 160.0 161.0 161.0 161.0 164.0 163.0 169.0 163.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#3] audio-fft Cycles:10 Average:89.40 Median:74.00 stddev:18.91 (25.6%) stddev-sans-first:19.22 11:53:06 INFO - PROCESS | 3682 | Values: 74.0 78.0 103.0 107.0 77.0 74.0 73.0 125.0 106.0 77.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:23.63 (25.1%) stddev-sans-first:24.48 11:53:06 INFO - PROCESS | 3682 | Values: 94.0 94.0 136.0 94.0 95.0 94.0 142.0 94.0 92.0 149.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 11:53:06 INFO - PROCESS | 3682 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 11:53:06 INFO - PROCESS | 3682 | Values: 147.0 146.0 146.0 145.0 147.0 145.0 147.0 146.0 146.0 146.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:53:06 INFO - PROCESS | 3682 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:64.50 stddev:5.81 (9.0%) stddev-sans-first:6.12 11:53:06 INFO - PROCESS | 3682 | Values: 64.0 64.0 64.0 65.0 64.0 65.0 65.0 82.0 64.0 61.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 11:53:06 INFO - PROCESS | 3682 | Values: 64.0 64.0 64.0 65.0 65.0 64.0 64.0 63.0 64.0 64.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:1.07 (1.3%) stddev-sans-first:1.01 11:53:06 INFO - PROCESS | 3682 | Values: 78.0 78.0 80.0 78.0 80.0 80.0 80.0 80.0 81.0 79.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:134.50 stddev:10.87 (8.1%) stddev-sans-first:11.50 11:53:06 INFO - PROCESS | 3682 | Values: 140.0 136.0 132.0 131.0 146.0 132.0 133.0 132.0 166.0 133.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:179.00 stddev:3.53 (2.0%) stddev-sans-first:3.62 11:53:06 INFO - PROCESS | 3682 | Values: 175.0 175.0 181.0 180.0 178.0 184.0 175.0 173.0 175.0 180.0 11:53:06 INFO - PROCESS | 3682 | 11:53:06 INFO - PROCESS | 3682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.50 stddev:2.11 (2.9%) stddev-sans-first:2.19 11:53:06 INFO - PROCESS | 3682 | Values: 74.0 76.0 73.0 71.0 70.0 71.0 74.0 75.0 73.0 70.0 11:53:06 INFO - PROCESS | 3682 | -------- Summary: end -------- 11:53:06 INFO - PROCESS | 3682 | 11:53:07 INFO - TEST-INFO | 3682: exit 0 11:53:07 INFO - TEST-OK | kraken | took 63521ms 11:53:07 INFO - SUITE-END | took 1183s 11:53:07 INFO - Completed test suite (00:19:43) 11:53:07 INFO - javascript benchmark 11:53:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.1494264364082, 2679.544477438835, 2685.9731402685966, 2695.6360891279683, 2716.6875809281937, 4498.820047198116, 4575.084983003404, 4581.289900065487, 4592.035672508773, 4604.631629469643, 4598.425196850394, 4607.17070927233, 4643.815826964119, 4690.202665546857, 4713.78787954542, 4184.30958891784, 4199.66402687785, 4201.117765269297, 4246.193223287565, 4401.3397990301555, 4353.238183317922, 4357.891052723676, 4368.868933931971, 4373.803178856959, 4410.448693913261, 4162.812673429673, 4249.702520823544, 4261.978690106561, 4304.354346847967, 4342.023044814891, 4264.019275566637, 4291.91416171678, 4332.350147477903, 4332.718373305725, 4373.978130109361, 4233.386159006957, 4280.400743895857, 4284.978575107105, 4288.056627541936, 4324.22164010478, 4418.5581441855875, 4551.613112885409, 4557.680962332638, 4559.17934771741, 4618.422697162855, 4899.436564795059, 4925.950740492585, 4928.975355123237, 4929.580985616227, 4968.552830245295, 4914.827981020647, 4951.059298733265, 4952.108620448318, 4959.2809042688605, 5005.349304590416, 4530.954690453119, 4638.11875743611, 4644.930326045112, 4716.127516409475, 4739.0, 5082.390113186441, 5091.0581542414775, 5096.847094587169, 5125.923111153335, 5176.5858731301405, 4920.237363208708, 4937.580305674058, 4942.4316203637045, 4951.5048495150195, 4971.975140124277, 4819.6867203631655, 4937.654364194472, 4975.651704380731, 4986.850394488171, 5000.324956130876, 4848.7090774553635, 4859.514048595112, 4860.781264843091, 4872.634552408584, 4914.336564563738, 4841.3222148899185, 4841.95158048422, 4859.052484765508, 4859.1496488114435, 4885.8045678173185, 4061.7156799023783, 4178.540360560336, 4259.765712885821, 4264.829406823692, 4265.7440553566885, 3692.2615476904725, 3695.260947810395, 3699.2416554606243, 3725.3294407006997, 3741.494898188764, 4242.681798865097, 4248.830046798155, 4255.787210639455, 4257.212415703043, 4295.0, 4869.050535145683, 4882.267659851051, 4931.753412329369, 4951.975240123848, 4960.379952505937, 4187.0, 4191.7484950903045, 4200.7479551227025, 4208.074223670787, 4218.915621687549, 4445.355423463579, 4447.221736196153, 4456.0, 4489.9775501122285, 4495.078508905666, 4513.413256276663, 4640.396748422683, 4680.438347398334, 4714.292856071616, 4718.929216061693, 4891.926621100615, 4892.657513973988, 4896.706197628154, 4905.877353066202, 4963.156263435297, 4520.095980803787, 4606.124836281096, 4610.631149507964, 4617.58441740245, 4665.906681866411, 4850.417949846041, 4885.462599114024, 4897.583705385082, 4929.211326187793, 4934.432540257772, 4902.044101400193, 4931.9753401232765, 4934.210526315772, 4937.572070460098, 4980.377452818398, 4683.508231635766, 4733.290006499053, 4747.406574178228, 4795.472498025145, 4833.250846118857, 4765.642576806684, 4786.928196076992, 4797.784099715452, 4811.49479304668, 4843.39457567804, 4684.281413405122, 4688.718676879398, 4710.26990816424, 4721.976390118028, 4780.354652121919, 4758.2386818108935, 4876.561109500162, 4878.5609295162185, 4878.878028049327, 4966.950330496648, 4647.674662773574, 4741.146593613183, 4757.7621118943225, 4781.330613714013, 4795.760211989317], "value": 4543.945871175067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.0853082626251, 578.7569220927207, 585.8681796595765, 601.4767152577257, 604.0787798607126, 25974.61038084428, 26516.73483265167, 26525.0, 26564.335891602695, 33258.84041016106, 36142.0, 36618.267634647294, 36777.632223677756, 36783.44824827623, 36819.26361472776, 7672.271134242252, 7808.0630324361155, 7857.960710196441, 7862.095858976234, 7867.1739467355965, 7370.189279179286, 9557.378770379937, 9805.460699661517, 9830.803383932318, 9840.704778856645, 9901.257405694565, 9921.751956201117, 10048.849267260997, 10055.547500362502, 10057.748556286078, 9784.755381115494, 9931.262029144871, 9937.65218217359, 9940.5029748513, 9947.60209591619, 9741.561629726679, 9839.262055345805, 9857.90142098577, 9864.829737457749, 10073.345232559861, 28611.0, 29401.41197176066, 29439.852800736073, 35785.642143578494, 36114.27771444556, 2343.8359314847967, 2632.223494069235, 2717.605947137674, 3131.4206871728575, 3199.5520627112223, 26240.475190496276, 29257.41485170306, 30079.69920300791, 30745.846270768503, 30976.845115774504, 3492.3713731528314, 3528.1003344147334, 3536.8585256589704, 3578.4632305154437, 3658.9634103659155, 229337.62617299057, 305362.0, 313495.0, 314206.428967856, 314506.0, 48669.75665121723, 48888.26667599989, 49136.0, 49152.50847491551, 49157.50842491529, 58113.128303075486, 58258.0, 58320.70839645775, 58377.70811146002, 58392.0, 13384.263865487297, 13481.797773033413, 13543.661408464866, 13559.728805424034, 13668.0, 9855.507224638739, 9931.106200441995, 9939.80120397588, 9987.101160895409, 10025.448600327052, 19093.618127637368, 19414.611707765765, 19425.580219496715, 19455.660236279575, 19463.8053619462, 7310.3448275862065, 7456.627168641547, 7535.284148005931, 7602.695892164252, 7675.0, 970.0396607358664, 970.84466485362, 980.8871979722423, 1022.4070039377143, 1034.1726618705006, 27638.585421218297, 27663.44673106567, 27899.581506277016, 28358.0, 28546.858125675157, 969.4280374579032, 991.1030517381781, 1018.1752780248023, 1033.9121174700235, 1076.4133547216786, 14260.714785704227, 14909.0, 15015.399384024735, 15219.315130819139, 15316.15761133126, 345286.0, 347480.0, 351398.0, 351521.0, 352573.0, 46501.767491162325, 47101.528984709716, 47309.29036064462, 47340.763296183984, 47369.763151184714, 1122.3826895207767, 1171.0807016492183, 1275.6810797300675, 1280.564608033273, 1286.0804524764837, 25258.0, 26569.33576660599, 27144.1856744298, 27629.309267267676, 27680.0, 37965.81017094897, 38612.80693596514, 38622.0, 38623.0, 38697.80651096727, 215112.0, 219641.0, 219948.0, 221258.0, 222007.0, 31750.682493174772, 31894.840525797223, 32913.506297406035, 32917.0, 32948.50577241295, 29293.121206363845, 35547.28905421825, 35612.50436256648, 36078.27843443169, 36104.819475902455, 29748.256293591967, 31514.527282091247, 31998.840005799822, 32712.83643581767, 34653.65346346605, 33657.0, 33853.32293354168, 34042.8297858519, 34125.48811767875, 34467.65532344745, 33105.66894331026, 33675.326493470486, 33993.320133596695, 34035.82982085173, 34068.488972664934, 30102.548461773527, 30689.846550767103, 30730.692693073677, 30975.535366969063, 31009.224769380042, 23328.300150995496, 23599.764002359756, 23896.0, 24076.51846963016, 24314.392140196636], "value": 17319.657049481684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1873285108505, 364.3496358999187, 370.4165938646631, 372.83408883047036, 382.57343062485336, 16147.999999999985, 16404.0, 16730.330786768514, 16753.581160470963, 16781.077040762753, 14802.925985370059, 16045.83954160458, 16171.757423638655, 16201.675966480692, 16206.837931620681, 4978.651494395403, 5185.222216667511, 5209.947900520984, 5222.712750798704, 5247.711375874325, 3591.120175556979, 5086.41506226785, 5614.214010038598, 5906.527477801766, 5958.8808223835495, 5845.269341332333, 5846.736896839631, 5871.412858714137, 5875.588708790387, 5882.529397648199, 5764.365919748824, 5843.328017278025, 5845.415458454163, 5846.941530584725, 5850.73671684773, 3292.3415316936707, 4877.487863774288, 5136.306598609177, 5141.922871156936, 5163.664361816507, 19291.51771205717, 19410.514737131543, 19460.0, 19770.40688779339, 20447.795522044737, 1918.2614693343023, 2007.247282269149, 2271.216430331533, 2286.5998450271304, 2289.6908917296287, 12985.22088674673, 13092.86907130926, 13214.471421143142, 13363.06458547902, 13768.724625507533, 1718.6562687462558, 1797.2810875649714, 1866.0762922353385, 1907.437305994721, 1916.3101283537915, 67698.66150669265, 68819.65590172067, 69696.65151674209, 70171.64914175447, 70439.29560704378, 9076.546172691338, 9151.862722059175, 9566.9043309566, 9832.606695732233, 10203.183745300357, 12981.935090324489, 13169.144005639602, 13195.538156164681, 13198.47206111764, 13216.867831321755, 6823.829404264834, 6872.728545219151, 6972.616506092214, 7028.578285302899, 7134.1795693495915, 6640.0703901453835, 6656.2345330287635, 6682.665866706742, 6749.42629876466, 6785.728570857111, 5916.461719952843, 6005.819825405245, 6043.909341359883, 6067.7876274331065, 6099.993501072273, 1613.9757903631455, 1677.8070521889895, 1694.466243133409, 1713.4431309824108, 1769.186174359783, 927.0914503786328, 956.2588993529931, 964.1997142371814, 974.0794948773341, 996.7906739584623, 16565.503034908972, 17015.23431445588, 17019.48941531756, 17418.12909354527, 17681.764183246793, 885.9158379953894, 909.1635695160468, 967.1150896929372, 1000.4097582426404, 1030.9381437113798, 9733.318667693193, 9870.25973052024, 10071.295009349275, 10088.991100889853, 10253.0, 382500.0, 390776.0, 403036.0, 405722.0, 405778.0, 68377.31622683808, 68465.3153468469, 68583.0, 69510.0, 69850.0, 952.9047095290415, 969.195567678839, 980.632262901412, 984.7045886234101, 988.7429268390271, 15114.09315441077, 15515.146666933428, 15523.301451434938, 15702.450414235447, 15795.289211985719, 31068.533971989986, 31785.682143178274, 32019.0, 32988.50517242291, 33184.336313274085, 40504.392434112924, 43007.49473768403, 43511.78244108886, 43961.34057989197, 44141.0, 7632.38940884739, 7646.923530764621, 7778.455508114378, 7933.286004259644, 7968.601569921597, 12044.638660840188, 12131.180322951628, 12207.328596927255, 12230.327331996825, 12444.440000200193, 5825.0388685866355, 6075.969620151871, 10731.678049658523, 10794.406307653155, 10891.346519208873, 9305.720828375159, 10256.641017564349, 10398.064174224357, 10510.211734120125, 10612.469376530988, 9967.651132210338, 10016.449095299828, 10323.380597164194, 10414.0, 10666.093382062301, 7842.058952925686, 8026.638801254075, 8035.638396272065, 8104.473209241381, 8175.223353781381, 9739.220862330854, 10198.388096714221, 10358.585656573652, 10473.371597704163, 10608.681739547827], "value": 8301.715994007973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.7382686549258, 1373.443755279112, 1430.4707258314422, 1533.3023474319186, 1746.9825301746978, 6283.780067697631, 7262.963685181573, 7478.32695057444, 7484.214157513465, 7484.476086673935, 7272.890906636405, 7436.739714110007, 7444.255574442553, 7451.329380355767, 7460.32857042866, 1859.888406695596, 2091.4666759976185, 2142.689310050042, 2147.38799442159, 2169.8264138868853, 2139.037433155079, 2139.208492857645, 2145.377840426282, 2155.7089792877996, 2156.7196264485597, 2148.4091874734495, 2164.9025793839237, 2165.404513758713, 2167.1331467413, 2167.2739632223224, 1900.4108726294824, 2071.399294204679, 2110.2930518276394, 2111.7043613894066, 2112.461322362803, 2053.404512691318, 2057.146284292017, 2057.9382618521317, 2060.536379314657, 2060.9381718548316, 7060.435165186773, 7091.432685385157, 7103.218645948941, 7103.928960710378, 7119.466040046966, 4188.204241194163, 4267.829286828523, 4330.761808100553, 4343.0, 4386.846460373904, 2830.985845070782, 2861.527847905093, 2882.2506148401358, 2884.1635925581554, 2933.3399985003416, 960.6109525642127, 971.9271054670928, 976.7997560500152, 982.0326977926736, 998.5606333213362, 10015.69952901414, 10021.148202402732, 10067.144292735125, 10078.244131690079, 10082.747931301703, 3935.4883865097354, 3986.0, 4150.688698347636, 4165.520965088993, 4218.346156345771, 8616.39685222041, 8652.740417787476, 8654.78363040929, 8656.09111043344, 8666.86999695005, 3771.7171212159196, 4546.795394207269, 4557.407537020166, 4583.54164583539, 4584.289435137559, 3931.8427262909163, 3999.7600143991453, 4002.579729128458, 4030.2946984277633, 4038.63652271297, 3393.406153923103, 3466.9133271667906, 3500.43992961125, 3516.367053930317, 3551.076720052753, 1146.0, 1161.465725766157, 1163.6450882480756, 1163.976720465586, 1173.7711146326556, 851.4423052900237, 859.4928991894687, 870.216804875617, 898.2095755734912, 915.2860768600502, 5241.0566098101945, 5248.7900483980975, 5298.125809241432, 5326.280952071421, 5439.0, 880.3925291548811, 892.2549671024638, 893.5621545442687, 927.2628260532757, 932.612965619274, 3557.9822100889846, 3577.874774382884, 3601.099725068733, 3654.2326111516877, 3696.611855755107, 8343.16568343173, 8630.82738345242, 8669.91330086691, 8729.825403491895, 8731.60707768152, 8670.696525621574, 8776.385653004356, 8818.426802257833, 8869.911300886908, 8887.0, 6794.0827988221945, 6952.756653517103, 7024.1571011478945, 7042.295770423019, 7059.0, 5333.679979201105, 5348.224507446476, 5353.625246232882, 5357.598180136428, 5530.695811730394, 8407.0, 8467.703630373153, 8564.785880352792, 8601.655933762579, 8667.306615470621, 8595.871061934202, 8653.091425400242, 8710.128987101492, 8712.172343627346, 8821.117888211384, 6270.874582508415, 6273.811785646438, 6391.424771770563, 6476.384743449365, 6498.902516462352, 7219.422446204396, 7220.89168662481, 7248.166460857069, 7254.818629534304, 7261.818454538678, 6499.415052645285, 6571.408573228432, 6622.801315960529, 6801.9319806801295, 6827.863442731217, 6297.1813664223355, 6416.13382193398, 6519.08732777402, 6619.569727967667, 6643.435307998874, 6040.577159598962, 6086.482648974709, 6139.324674285915, 6184.072389141485, 6313.715882785377, 4360.7601581913295, 4470.150671372428, 4600.3329517219145, 4607.539246075366, 4639.234526303258, 4378.496472905529, 4484.080763443421, 4636.675432719677, 4705.670603057753, 4751.952480475289], "value": 4024.0749402347906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.6383684231552, 304.1574837699572, 304.7836036414146, 309.60370725471404, 310.55125343878103, 4876.561109500144, 5001.749912504374, 5033.446320904697, 5042.873928151798, 5043.84868453947, 4846.806127754894, 5058.721770302632, 5063.9493605063935, 5069.290299358093, 5071.290019397287, 3974.2250261198933, 3974.562003866656, 3980.9402858957137, 3985.2228815381013, 3994.6604538614106, 3757.3988161894104, 3796.5762838935398, 3959.821808018646, 3983.302921988655, 3986.3621820508724, 3927.9803600981954, 3937.2519221347998, 3939.443919651736, 3944.349182384903, 3949.8617548385814, 3889.9027524311978, 3900.609939006105, 3910.1593157470998, 3923.431102490123, 3949.19041596472, 3476.4263896457055, 3481.582210134775, 3482.564679415073, 3483.6342184070813, 3485.930281394383, 4611.930821037688, 4858.587020103296, 4865.075635629254, 4883.095592718842, 4901.289313049623, 4412.139632771611, 4417.602415782595, 4449.710768800018, 4453.0, 4454.13144436835, 5312.379724184122, 5341.679499230058, 5350.35795704514, 5357.116075847481, 5368.409474957752, 3524.1189702574356, 3714.461403096536, 3715.1640880801874, 3729.067733066733, 3745.756525825813, 5429.267048948381, 5522.116461366162, 5561.499465048125, 5562.887422515513, 5564.8330550083565, 3786.3184626767447, 3800.2969450651717, 3817.828197731109, 3818.675412589961, 3834.482344883461, 3637.636236376341, 3846.6728978502933, 3860.3630400983525, 3874.1476875087437, 3879.592642772525, 4363.781810909441, 4393.209222339946, 4404.889877753082, 4410.294352903584, 4411.889702757392, 5306.699858534606, 5311.48622642545, 5319.787208511693, 5324.254604355393, 5334.17320315344, 1271.8664540223328, 1294.7734146524508, 1328.216352352117, 1335.4457899971596, 1337.6522104252965, 876.4215617692292, 879.4371602174614, 902.0, 903.1871315815819, 914.5107367558325, 4599.505160822746, 4613.515580864028, 4620.607248383858, 4622.14490319292, 4626.791794369262, 5387.488188622075, 5432.103702889058, 5436.891262174734, 5437.401885792559, 5453.64551304164, 4467.776611169428, 4597.839075632337, 4606.0, 4608.3778689876435, 4611.538846115429, 2881.236472334833, 2890.682024977251, 2894.3343031102963, 2895.0880472651047, 2895.5077636801793, 5044.9495505045215, 5091.8981620367385, 5108.56577190943, 5116.641835071509, 5139.691618502827, 5262.289590905255, 5534.833954981357, 5550.639208451437, 5559.555235581144, 5633.352164501053, 5121.539061484485, 5123.590112790967, 5144.9742751286, 5158.349328214935, 5162.225666150108, 5446.673199608036, 5453.700046497481, 5470.72646367688, 5477.782107777069, 5478.808241711521, 5271.130263506632, 5370.704611246419, 5377.139657654757, 5414.29614150158, 5421.539169170507, 5109.156989096906, 5118.0, 5147.382314122329, 5162.819301324435, 5165.405978312392, 3742.326381251401, 3766.9058273543383, 3773.2830762155104, 3776.244751049746, 3781.903248058032, 5226.686398816083, 5328.120860058047, 5427.375851777097, 5442.755076021668, 5458.590605704668, 5162.8193013245855, 5266.73666316675, 5353.330833645794, 5365.517103460707, 5366.0, 5321.574274058144, 5333.333333333333, 5348.545373643284, 5356.196570514454, 5360.839174824761, 5128.769205385841, 5257.161132988296, 5260.631755777059, 5261.237120617412, 5281.910082601721, 5358.169483730028, 5366.7048312343195, 5386.0, 5386.5152136307925, 5390.595705322195, 5244.606654501004, 5245.265662807134, 5264.684118952875, 5268.473152684701, 5272.130098533699], "value": 3971.9776238609, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.6416131530946, 689.4484412470023, 693.6809067828799, 748.7080038784873, 781.2148790465579, 11375.488103035363, 12150.635480935563, 12427.254364738123, 12499.18755280906, 12718.872811271896, 13390.66523336917, 13428.865711342884, 13494.0, 13581.728365432686, 13611.251381174032, 636.4049613611288, 781.5076501803884, 810.0441479054698, 817.6770175780563, 819.1767273889733, 817.9672813087469, 823.1644880446352, 823.6087858267335, 824.4970567953544, 824.7360844529753, 855.6962278391175, 856.3919617071887, 858.9570521473933, 861.1044513705739, 862.094800459515, 669.2571245917028, 810.4812919731377, 853.6884037326394, 854.3208149521115, 856.015582080606, 625.1154616218046, 625.4308579192958, 625.7590827531387, 625.7872323410016, 625.8685676008043, 11408.486618102123, 11459.197856150073, 11466.369349685763, 11468.082553395709, 11481.598144065001, 12366.319852408114, 12633.684157896034, 12832.743345133138, 12919.67700807478, 13064.934675326658, 9928.602855885756, 10167.694969150938, 10181.45865998228, 10330.7417314567, 10366.844497332546, 4276.2089013532595, 4285.571442855689, 4301.870943871689, 4330.805113769888, 4475.709078909893, 45789.31316030262, 46911.765441172574, 46987.0, 47021.29468058016, 47131.764341178416, 9932.404055756677, 10086.29395942277, 10106.646267380607, 10247.897521024694, 10257.17942564593, 18091.909540452212, 18095.72856407155, 18103.818961810477, 18106.818931810776, 18120.456386308433, 6931.1682598088555, 7023.508354415142, 7024.473164512579, 7163.6060016699585, 7207.783766487014, 3878.4764056852528, 3915.1190982029384, 3919.8040097994985, 3920.9607903921165, 3956.050547868491, 2907.9854600727285, 2947.3073827650487, 2961.4669359515065, 2968.5250359942306, 2970.12381347503, 513.7559659161943, 514.5831876180306, 517.9792808287701, 518.1036806325079, 524.3692117514527, 614.5237440983274, 624.1168746224133, 645.3997782062632, 648.5362965479704, 654.8919428294278, 7899.210078992055, 7954.880676789853, 8013.559254240956, 8195.7951051223, 8408.285295749929, 604.072748331318, 656.1309090188315, 673.1686367336335, 676.972921083161, 678.375894177358, 3861.169848482534, 3972.940405893856, 3994.3409337458993, 4003.779792111462, 4027.496562929634, 50595.0, 51598.48401515937, 51633.48366516362, 51640.225396619084, 51769.0, 42858.35712464315, 43510.34734478922, 43763.0, 44030.0, 44112.55887441149, 41567.713775742624, 41943.370849437284, 42444.0, 42808.3578746319, 42953.0, 7480.962595187207, 7770.898140510449, 7775.0, 7783.299503044753, 7969.840603187788, 27927.441451170456, 28159.296017599725, 28267.57598635981, 29423.55864661989, 29539.26151846135, 34210.31579368449, 35132.64867351396, 37433.625663744104, 37792.811035944644, 37922.62077379191, 9916.256280778825, 10034.899651003396, 10069.575588907896, 10216.642417515352, 10260.230482713678, 10414.271001029856, 10562.8415573768, 10959.232853700165, 11010.669679909295, 11335.943320283346, 8012.203033919712, 10553.366797992145, 11201.215914886207, 11217.775644487228, 11377.54489820431, 10886.346819190874, 11292.378919159524, 11534.077273817906, 11570.132240082195, 11652.94173529127, 9900.752481188028, 10004.0, 10107.898921010696, 10321.329113607591, 10384.584616615251, 9452.95273523628, 9855.31012829095, 10012.84980725275, 10036.247281454067, 10174.796504070026, 9217.893852737714, 9580.568874400808, 9616.95191524038, 9692.224622030362, 9699.17557007634], "value": 5997.449473178485, "unit": "score"}], "name": "dromaeo_css", "value": 6301.899648062675, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 110.0, 114.0, 116.0, 115.0, 103.0, 112.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 132.0, 156.0, 184.0, 132.0, 159.0, 157.0, 133.0, 184.0, 131.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 164.0, 163.0, 169.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 103.0, 107.0, 77.0, 74.0, 73.0, 125.0, 106.0, 77.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 136.0, 94.0, 95.0, 94.0, 142.0, 94.0, 92.0, 149.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 147.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 82.0, 64.0, 61.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 78.0, 80.0, 80.0, 80.0, 80.0, 81.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 132.0, 131.0, 146.0, 132.0, 133.0, 132.0, 166.0, 133.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 181.0, 180.0, 178.0, 184.0, 175.0, 173.0, 175.0, 180.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 71.0, 70.0, 71.0, 74.0, 75.0, 73.0, 70.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1581.6, "alertThreshold": 2.0}]} 11:53:07 INFO - Return code: 0 11:53:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:53:07 ERROR - # TBPL SUCCESS # 11:53:07 INFO - Running post-action listener: _resource_record_post_action 11:53:07 INFO - Running post-run listener: _resource_record_post_run 11:53:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7680000; Write bytes: 422236160; Read time: 1264; Write time: 256364 11:53:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 149970944; Read time: 200; Write time: 85028 11:53:09 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 7675904; Write bytes: 272265216; Read time: 1064; Write time: 171336 11:53:09 INFO - Running post-run listener: _upload_blobber_files 11:53:09 INFO - Blob upload gear active. 11:53:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:53:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:53:09 INFO - (blobuploader) - INFO - Open directory for files ... 11:53:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:53:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:53:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:10 INFO - (blobuploader) - INFO - Done attempting. 11:53:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:53:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:11 INFO - (blobuploader) - INFO - Done attempting. 11:53:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:53:11 INFO - Return code: 0 11:53:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:53:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:53:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9419c5a618c145fff058f13964694847f2963ba2c30dc4039f62f033e701b7e0a41921e14b99ffff50d045474826dd105f08ca9738fc5d6cc6a75affd49741db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb2f89b4ac369801852778d3ad219728bca991835fbef12dd0ffa24799947dc530751af85e185199db8a2c025c666fdf4b56acbe82ce33e195caa627e0e1d35f"} 11:53:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:53:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:53:11 INFO - Contents: 11:53:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9419c5a618c145fff058f13964694847f2963ba2c30dc4039f62f033e701b7e0a41921e14b99ffff50d045474826dd105f08ca9738fc5d6cc6a75affd49741db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb2f89b4ac369801852778d3ad219728bca991835fbef12dd0ffa24799947dc530751af85e185199db8a2c025c666fdf4b56acbe82ce33e195caa627e0e1d35f"} 11:53:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:53:11 INFO - Copying logs to upload dir... 11:53:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:53:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.394701 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-21 11:53:11.214599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 11:53:11.218423) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9419c5a618c145fff058f13964694847f2963ba2c30dc4039f62f033e701b7e0a41921e14b99ffff50d045474826dd105f08ca9738fc5d6cc6a75affd49741db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb2f89b4ac369801852778d3ad219728bca991835fbef12dd0ffa24799947dc530751af85e185199db8a2c025c666fdf4b56acbe82ce33e195caa627e0e1d35f"} build_url:https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/HLkuEv01T4eedHTpyzRFuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9419c5a618c145fff058f13964694847f2963ba2c30dc4039f62f033e701b7e0a41921e14b99ffff50d045474826dd105f08ca9738fc5d6cc6a75affd49741db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb2f89b4ac369801852778d3ad219728bca991835fbef12dd0ffa24799947dc530751af85e185199db8a2c025c666fdf4b56acbe82ce33e195caa627e0e1d35f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 11:53:11.243106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:53:11.243443) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461263512.274659-1960490801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:53:11.326996) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 11:53:11.327366) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 11:53:11.327684) ========= ========= Total master_lag: 0.41 =========