builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1461248116.57 results: success (0) buildid: 20160421063405 builduid: 9c03b139c2794d3ea8513edbf9814b55 revision: 4ac3b4265ce2205bab28de9f09da31379e23b785 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.568239) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.568698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.568998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.649772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.650336) ========= 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=db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 07:15:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-21 07:15:17 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127657 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.794794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.795119) ========= 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=db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020079 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.845944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:16.846323) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4ac3b4265ce2205bab28de9f09da31379e23b785 --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 4ac3b4265ce2205bab28de9f09da31379e23b785 --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=db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 07:15:17,252 truncating revision to first 12 chars 2016-04-21 07:15:17,252 Setting DEBUG logging. 2016-04-21 07:15:17,253 attempt 1/10 2016-04-21 07:15:17,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4ac3b4265ce2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 07:15:17,494 unpacking tar archive at: fx-team-4ac3b4265ce2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590265 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:17.449107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:17.449397) ========= script_repo_revision: 4ac3b4265ce2205bab28de9f09da31379e23b785 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:17.449776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:17.450054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:15:17.471409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-04-21 07:15:17.471674) ========= /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=db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:17 INFO - MultiFileLogger online at 20160421 07:15:17 in /builds/slave/test 07:15:17 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 07:15:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:17 INFO - {'append_to_log': False, 07:15:17 INFO - 'base_work_dir': '/builds/slave/test', 07:15:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:15:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:17 INFO - 'branch': 'Fx-Team-Non-PGO', 07:15:17 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:17 INFO - 'config_files': ('talos/linux_config.py',), 07:15:17 INFO - 'default_actions': ('clobber', 07:15:17 INFO - 'read-buildbot-config', 07:15:17 INFO - 'download-and-extract', 07:15:17 INFO - 'populate-webroot', 07:15:17 INFO - 'create-virtualenv', 07:15:17 INFO - 'install', 07:15:17 INFO - 'run-tests'), 07:15:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:17 INFO - 'download_minidump_stackwalk': True, 07:15:17 INFO - 'download_symbols': 'ondemand', 07:15:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:17 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:17 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:17 INFO - 'installer_path': 'installer.exe', 07:15:17 INFO - 'log_level': 'info', 07:15:17 INFO - 'log_name': 'talos', 07:15:17 INFO - 'log_to_console': True, 07:15:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:17 INFO - 'opt_config_files': (), 07:15:17 INFO - 'pip_index': False, 07:15:17 INFO - 'sps_profile': False, 07:15:17 INFO - 'sps_profile_interval': 0, 07:15:17 INFO - 'suite': 'dromaeojs', 07:15:17 INFO - 'system_bits': '32', 07:15:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:17 INFO - 'title': 'talos-linux64-ix-031', 07:15:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:17 INFO - 'use_talos_json': True, 07:15:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:17 INFO - 'work_dir': 'build'} 07:15:17 INFO - ##### 07:15:17 INFO - ##### Running clobber step. 07:15:17 INFO - ##### 07:15:17 INFO - Running pre-action listener: _resource_record_pre_action 07:15:17 INFO - Running main action method: clobber 07:15:17 INFO - rmtree: /builds/slave/test/build 07:15:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:18 INFO - Running post-action listener: _resource_record_post_action 07:15:18 INFO - ##### 07:15:18 INFO - ##### Running read-buildbot-config step. 07:15:18 INFO - ##### 07:15:18 INFO - Running pre-action listener: _resource_record_pre_action 07:15:18 INFO - Running main action method: read_buildbot_config 07:15:18 INFO - Using buildbot properties: 07:15:18 INFO - { 07:15:18 INFO - "project": "", 07:15:18 INFO - "product": "firefox", 07:15:18 INFO - "script_repo_revision": "production", 07:15:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:15:18 INFO - "repository": "", 07:15:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:15:18 INFO - "buildid": "20160421063405", 07:15:18 INFO - "pgo_build": "False", 07:15:18 INFO - "basedir": "/builds/slave/test", 07:15:18 INFO - "buildnumber": 1580, 07:15:18 INFO - "slavename": "talos-linux64-ix-031", 07:15:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:15:18 INFO - "platform": "ubuntu64_hw", 07:15:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:15:18 INFO - "branch": "fx-team", 07:15:18 INFO - "repo_path": "integration/fx-team", 07:15:18 INFO - "revision": "4ac3b4265ce2205bab28de9f09da31379e23b785", 07:15:18 INFO - "stage_platform": "linux64", 07:15:18 INFO - "builduid": "9c03b139c2794d3ea8513edbf9814b55", 07:15:18 INFO - "slavebuilddir": "test" 07:15:18 INFO - } 07:15:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:15:18 INFO - Running post-action listener: _resource_record_post_action 07:15:18 INFO - ##### 07:15:18 INFO - ##### Running download-and-extract step. 07:15:18 INFO - ##### 07:15:18 INFO - Running pre-action listener: _resource_record_pre_action 07:15:18 INFO - Running main action method: download_and_extract 07:15:18 INFO - mkdir: /builds/slave/test/build/tests 07:15:18 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')]} 07:15:18 INFO - https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:15:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:15:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:15:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:21 INFO - Downloaded 1361 bytes. 07:15:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:15:21 INFO - Using the following test package requirements: 07:15:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:15:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:15:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'jsshell-linux-x86_64.zip'], 07:15:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:15:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:15:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:15:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:15:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:15:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:15: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')]} 07:15:21 INFO - https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:22 INFO - Downloaded 22275480 bytes. 07:15:22 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'] 07:15:22 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 07:15:23 INFO - Return code: 0 07:15:23 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 07:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:23 INFO - https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:39 INFO - Downloaded 22275480 bytes. 07:15:39 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'] 07:15:39 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 07:15:40 INFO - Return code: 0 07:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:40 INFO - https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:43 INFO - Downloaded 10845952 bytes. 07:15:43 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'] 07:15:43 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 07:15:43 INFO - Return code: 0 07:15: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')]} 07:15:43 INFO - https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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 07:15:45 INFO - Downloaded 54620928 bytes. 07:15:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:15:45 INFO - mkdir: /builds/slave/test/properties 07:15:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:45 INFO - Contents: 07:15:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:15:46 INFO - Running post-action listener: _resource_record_post_action 07:15:46 INFO - Running post-action listener: set_extra_try_arguments 07:15:46 INFO - ##### 07:15:46 INFO - ##### Running populate-webroot step. 07:15:46 INFO - ##### 07:15:46 INFO - Running pre-action listener: _resource_record_pre_action 07:15:46 INFO - Running main action method: populate_webroot 07:15:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:46 INFO - '--tppagecycles', 07:15:46 INFO - '7'], 07:15:46 INFO - 'tests': ['tsvgm']}}, 07:15:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['damp', 'tps']}, 07:15:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'tests': ['damp', 'tps']}, 07:15:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['dromaeo_dom']}, 07:15:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['a11yr', 07:15:46 INFO - 'ts_paint', 07:15:46 INFO - 'tpaint', 07:15:46 INFO - 'sessionrestore', 07:15:46 INFO - 'sessionrestore_no_auto_restore', 07:15:46 INFO - 'tabpaint']}, 07:15:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:46 INFO - 'ts_paint', 07:15:46 INFO - 'tpaint', 07:15:46 INFO - 'sessionrestore', 07:15:46 INFO - 'sessionrestore_no_auto_restore', 07:15:46 INFO - 'tabpaint']}, 07:15:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:46 INFO - 'ts_paint', 07:15:46 INFO - 'tpaint', 07:15:46 INFO - 'sessionrestore', 07:15:46 INFO - 'sessionrestore_no_auto_restore', 07:15:46 INFO - 'tabpaint']}, 07:15:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:46 INFO - 'ts_paint', 07:15:46 INFO - 'tpaint', 07:15:46 INFO - 'sessionrestore', 07:15:46 INFO - 'sessionrestore_no_auto_restore', 07:15:46 INFO - 'tabpaint']}, 07:15:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['a11yr', 07:15:46 INFO - 'ts_paint', 07:15:46 INFO - 'tpaint', 07:15:46 INFO - 'sessionrestore', 07:15:46 INFO - 'sessionrestore_no_auto_restore', 07:15:46 INFO - 'tabpaint']}, 07:15:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['a11yr', 07:15:46 INFO - 'ts_paint', 07:15:46 INFO - 'tpaint', 07:15:46 INFO - 'sessionrestore', 07:15:46 INFO - 'sessionrestore_no_auto_restore', 07:15:46 INFO - 'tabpaint']}, 07:15:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['tsvgx', 07:15:46 INFO - 'tsvgr_opacity', 07:15:46 INFO - 'tart', 07:15:46 INFO - 'tscrollx', 07:15:46 INFO - 'cart']}, 07:15:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:46 INFO - 'tsvgr_opacity', 07:15:46 INFO - 'tart', 07:15:46 INFO - 'tscrollx', 07:15:46 INFO - 'cart']}, 07:15:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'talos_options': ['--disable-e10s'], 07:15:46 INFO - 'tests': ['tp5o']}, 07:15:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'tests': ['tp5o']}, 07:15:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'talos_options': ['--disable-e10s', 07:15:46 INFO - '--xperf_path', 07:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:46 INFO - 'tests': ['tp5n']}, 07:15:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:46 INFO - 'talos_options': ['--xperf_path', 07:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:46 INFO - 'tests': ['tp5n']}}, 07:15:46 INFO - 'talos.zip': {'path': '', 07:15:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:46 INFO - Running post-action listener: _resource_record_post_action 07:15:46 INFO - ##### 07:15:46 INFO - ##### Running create-virtualenv step. 07:15:46 INFO - ##### 07:15:46 INFO - Running pre-action listener: _resource_record_pre_action 07:15:46 INFO - Running main action method: create_virtualenv 07:15:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:46 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 07:15:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:46 INFO - Using real prefix '/usr' 07:15:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:48 INFO - Installing pip.................done. 07:15:48 INFO - Return code: 0 07:15:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:48 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:15:48 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 07:15:48 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 07:15:48 INFO - Using env: {'DISPLAY': ':0', 07:15:48 INFO - 'HOME': '/home/cltbld', 07:15:48 INFO - 'LANG': 'en_US.UTF-8', 07:15:48 INFO - 'LANGUAGE': 'en_US:en', 07:15:48 INFO - 'LOGNAME': 'cltbld', 07:15:48 INFO - 'MAIL': '/var/mail/cltbld', 07:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:48 INFO - 'MOZ_NO_REMOTE': '1', 07:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:48 INFO - 'NO_EM_RESTART': '1', 07:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:48 INFO - 'PWD': '/builds/slave/test', 07:15:48 INFO - 'SHELL': '/bin/bash', 07:15:48 INFO - 'SHLVL': '1', 07:15:48 INFO - 'TERM': 'linux', 07:15:48 INFO - 'TMOUT': '86400', 07:15:48 INFO - 'USER': 'cltbld', 07:15:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:48 INFO - '_': '/tools/buildbot/bin/python'} 07:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:48 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 07:15:48 INFO - Cleaning up... 07:15:48 INFO - Return code: 0 07:15:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:48 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:15:48 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 07:15:48 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 07:15:48 INFO - Using env: {'DISPLAY': ':0', 07:15:48 INFO - 'HOME': '/home/cltbld', 07:15:48 INFO - 'LANG': 'en_US.UTF-8', 07:15:48 INFO - 'LANGUAGE': 'en_US:en', 07:15:48 INFO - 'LOGNAME': 'cltbld', 07:15:48 INFO - 'MAIL': '/var/mail/cltbld', 07:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:48 INFO - 'MOZ_NO_REMOTE': '1', 07:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:48 INFO - 'NO_EM_RESTART': '1', 07:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:48 INFO - 'PWD': '/builds/slave/test', 07:15:48 INFO - 'SHELL': '/bin/bash', 07:15:48 INFO - 'SHLVL': '1', 07:15:48 INFO - 'TERM': 'linux', 07:15:48 INFO - 'TMOUT': '86400', 07:15:48 INFO - 'USER': 'cltbld', 07:15:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:48 INFO - '_': '/tools/buildbot/bin/python'} 07:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:49 INFO - Downloading/unpacking psutil>=0.7.1 07:15:49 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 07:15:49 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 07:15:49 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 07:15:49 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 07:15:49 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 07:15:49 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 07:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:51 INFO - Installing collected packages: psutil 07:15:51 INFO - Running setup.py install for psutil 07:15:51 INFO - building 'psutil._psutil_linux' extension 07:15:51 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 07:15:51 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 07:15:51 INFO - building 'psutil._psutil_posix' extension 07:15:51 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 07:15:51 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 07:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:51 INFO - Successfully installed psutil 07:15:51 INFO - Cleaning up... 07:15:51 INFO - Return code: 0 07:15:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:51 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:15:51 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 07:15:51 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 07:15:51 INFO - Using env: {'DISPLAY': ':0', 07:15:51 INFO - 'HOME': '/home/cltbld', 07:15:51 INFO - 'LANG': 'en_US.UTF-8', 07:15:51 INFO - 'LANGUAGE': 'en_US:en', 07:15:51 INFO - 'LOGNAME': 'cltbld', 07:15:51 INFO - 'MAIL': '/var/mail/cltbld', 07:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:51 INFO - 'MOZ_NO_REMOTE': '1', 07:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:51 INFO - 'NO_EM_RESTART': '1', 07:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:51 INFO - 'PWD': '/builds/slave/test', 07:15:51 INFO - 'SHELL': '/bin/bash', 07:15:51 INFO - 'SHLVL': '1', 07:15:51 INFO - 'TERM': 'linux', 07:15:51 INFO - 'TMOUT': '86400', 07:15:51 INFO - 'USER': 'cltbld', 07:15:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:51 INFO - '_': '/tools/buildbot/bin/python'} 07:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:15:54 INFO - Installing collected packages: mozsystemmonitor 07:15:54 INFO - Running setup.py install for mozsystemmonitor 07:15:54 INFO - Successfully installed mozsystemmonitor 07:15:54 INFO - Cleaning up... 07:15:54 INFO - Return code: 0 07:15:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:15:54 INFO - Using env: {'DISPLAY': ':0', 07:15:54 INFO - 'HOME': '/home/cltbld', 07:15:54 INFO - 'LANG': 'en_US.UTF-8', 07:15:54 INFO - 'LANGUAGE': 'en_US:en', 07:15:54 INFO - 'LOGNAME': 'cltbld', 07:15:54 INFO - 'MAIL': '/var/mail/cltbld', 07:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:54 INFO - 'MOZ_NO_REMOTE': '1', 07:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:54 INFO - 'NO_EM_RESTART': '1', 07:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:54 INFO - 'PWD': '/builds/slave/test', 07:15:54 INFO - 'SHELL': '/bin/bash', 07:15:54 INFO - 'SHLVL': '1', 07:15:54 INFO - 'TERM': 'linux', 07:15:54 INFO - 'TMOUT': '86400', 07:15:54 INFO - 'USER': 'cltbld', 07:15:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:54 INFO - '_': '/tools/buildbot/bin/python'} 07:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:56 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 INFO - Downloading docopt-0.6.1.tar.gz 07:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:57 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:57 INFO - Running setup.py install for blobuploader 07:15:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:57 INFO - Running setup.py install for requests 07:15:58 INFO - Running setup.py install for docopt 07:15:58 INFO - Successfully installed blobuploader requests docopt 07:15:58 INFO - Cleaning up... 07:15:58 INFO - Return code: 0 07:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:58 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:15:58 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 07:15:58 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 07:15:58 INFO - Using env: {'DISPLAY': ':0', 07:15:58 INFO - 'HOME': '/home/cltbld', 07:15:58 INFO - 'LANG': 'en_US.UTF-8', 07:15:58 INFO - 'LANGUAGE': 'en_US:en', 07:15:58 INFO - 'LOGNAME': 'cltbld', 07:15:58 INFO - 'MAIL': '/var/mail/cltbld', 07:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:58 INFO - 'MOZ_NO_REMOTE': '1', 07:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:58 INFO - 'NO_EM_RESTART': '1', 07:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:58 INFO - 'PWD': '/builds/slave/test', 07:15:58 INFO - 'SHELL': '/bin/bash', 07:15:58 INFO - 'SHLVL': '1', 07:15:58 INFO - 'TERM': 'linux', 07:15:58 INFO - 'TMOUT': '86400', 07:15:58 INFO - 'USER': 'cltbld', 07:15:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:58 INFO - '_': '/tools/buildbot/bin/python'} 07:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:58 INFO - Running setup.py (path:/tmp/pip-2wUhsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:58 INFO - Running setup.py (path:/tmp/pip-QFafrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:58 INFO - Running setup.py (path:/tmp/pip-nukwoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:58 INFO - Running setup.py (path:/tmp/pip-5NqZSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:58 INFO - Running setup.py (path:/tmp/pip-MRzV0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:58 INFO - Running setup.py (path:/tmp/pip-pn8dvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:58 INFO - Running setup.py (path:/tmp/pip-ulrUfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:59 INFO - Running setup.py (path:/tmp/pip-C3WD87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:59 INFO - Running setup.py (path:/tmp/pip-P3lnJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:59 INFO - Running setup.py (path:/tmp/pip-nml5OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:59 INFO - Running setup.py (path:/tmp/pip-C8vCPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:59 INFO - Running setup.py (path:/tmp/pip-Tfrmmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:59 INFO - Running setup.py (path:/tmp/pip-EuRkzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:59 INFO - Running setup.py (path:/tmp/pip-wApKln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:59 INFO - Running setup.py (path:/tmp/pip-dPTr6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:59 INFO - Running setup.py (path:/tmp/pip-DY_HoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:59 INFO - Running setup.py (path:/tmp/pip-zrbBe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:59 INFO - Running setup.py install for manifestparser 07:15:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozcrash 07:15:59 INFO - Running setup.py install for mozdebug 07:16:00 INFO - Running setup.py install for mozdevice 07:16:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for mozfile 07:16:00 INFO - Running setup.py install for mozhttpd 07:16:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for mozinfo 07:16:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for mozInstall 07:16:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for mozleak 07:16:00 INFO - Running setup.py install for mozlog 07:16:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for moznetwork 07:16:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for mozprocess 07:16:00 INFO - Running setup.py install for mozprofile 07:16:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:16:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:16:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:16:01 INFO - Running setup.py install for mozrunner 07:16:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:16:01 INFO - Running setup.py install for mozscreenshot 07:16:01 INFO - Running setup.py install for moztest 07:16:01 INFO - Running setup.py install for mozversion 07:16:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:16:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:16:01 INFO - Cleaning up... 07:16:01 INFO - Return code: 0 07:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:01 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')]} 07:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:01 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')]} 07:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:01 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:16:01 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 07:16:01 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 07:16:01 INFO - Using env: {'DISPLAY': ':0', 07:16:01 INFO - 'HOME': '/home/cltbld', 07:16:01 INFO - 'LANG': 'en_US.UTF-8', 07:16:01 INFO - 'LANGUAGE': 'en_US:en', 07:16:01 INFO - 'LOGNAME': 'cltbld', 07:16:01 INFO - 'MAIL': '/var/mail/cltbld', 07:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:01 INFO - 'MOZ_NO_REMOTE': '1', 07:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:01 INFO - 'NO_EM_RESTART': '1', 07:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:01 INFO - 'PWD': '/builds/slave/test', 07:16:01 INFO - 'SHELL': '/bin/bash', 07:16:01 INFO - 'SHLVL': '1', 07:16:01 INFO - 'TERM': 'linux', 07:16:01 INFO - 'TMOUT': '86400', 07:16:01 INFO - 'USER': 'cltbld', 07:16:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:01 INFO - '_': '/tools/buildbot/bin/python'} 07:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:01 INFO - Running setup.py (path:/tmp/pip-0c6NK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:01 INFO - Running setup.py (path:/tmp/pip-e3OHwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:01 INFO - Running setup.py (path:/tmp/pip-AubhJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:01 INFO - Running setup.py (path:/tmp/pip-OUe3WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:02 INFO - Running setup.py (path:/tmp/pip-ZPYIBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:02 INFO - Running setup.py (path:/tmp/pip-tTLIL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:02 INFO - Running setup.py (path:/tmp/pip-d6oTAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:02 INFO - Running setup.py (path:/tmp/pip-4Gebai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:02 INFO - Running setup.py (path:/tmp/pip-KHQTpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:02 INFO - Running setup.py (path:/tmp/pip-3dRPUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:02 INFO - Running setup.py (path:/tmp/pip-Sj4Pnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:02 INFO - Running setup.py (path:/tmp/pip-cn7ilV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:02 INFO - Running setup.py (path:/tmp/pip-NcXFjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:02 INFO - Running setup.py (path:/tmp/pip-zk2QdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:02 INFO - Running setup.py (path:/tmp/pip-NnMtA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:02 INFO - Running setup.py (path:/tmp/pip-rOFBHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:02 INFO - Running setup.py (path:/tmp/pip-WEscMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:02 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 07:16:02 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 07:16:02 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 07:16:02 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 07:16:02 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 07:16:02 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 07:16:04 INFO - Downloading blessings-1.6.tar.gz 07:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:04 INFO - Installing collected packages: blessings 07:16:04 INFO - Running setup.py install for blessings 07:16:05 INFO - Successfully installed blessings 07:16:05 INFO - Cleaning up... 07:16:05 INFO - Return code: 0 07:16:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:05 INFO - Reading from file tmpfile_stdout 07:16:05 INFO - Current package versions: 07:16:05 INFO - argparse == 1.2.1 07:16:05 INFO - blessings == 1.6 07:16:05 INFO - blobuploader == 1.2.4 07:16:05 INFO - docopt == 0.6.1 07:16:05 INFO - manifestparser == 1.1 07:16:05 INFO - mozInstall == 1.12 07:16:05 INFO - mozcrash == 0.17 07:16:05 INFO - mozdebug == 0.1 07:16:05 INFO - mozdevice == 0.48 07:16:05 INFO - mozfile == 1.2 07:16:05 INFO - mozhttpd == 0.7 07:16:05 INFO - mozinfo == 0.9 07:16:05 INFO - mozleak == 0.1 07:16:05 INFO - mozlog == 3.1 07:16:05 INFO - moznetwork == 0.27 07:16:05 INFO - mozprocess == 0.22 07:16:05 INFO - mozprofile == 0.28 07:16:05 INFO - mozrunner == 6.11 07:16:05 INFO - mozscreenshot == 0.1 07:16:05 INFO - mozsystemmonitor == 0.0 07:16:05 INFO - moztest == 0.7 07:16:05 INFO - mozversion == 1.4 07:16:05 INFO - psutil == 3.1.1 07:16:05 INFO - requests == 1.2.3 07:16:05 INFO - wsgiref == 0.1.2 07:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:05 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:16:05 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 07:16:05 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 07:16:05 INFO - Using env: {'DISPLAY': ':0', 07:16:05 INFO - 'HOME': '/home/cltbld', 07:16:05 INFO - 'LANG': 'en_US.UTF-8', 07:16:05 INFO - 'LANGUAGE': 'en_US:en', 07:16:05 INFO - 'LOGNAME': 'cltbld', 07:16:05 INFO - 'MAIL': '/var/mail/cltbld', 07:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:05 INFO - 'MOZ_NO_REMOTE': '1', 07:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:05 INFO - 'NO_EM_RESTART': '1', 07:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:05 INFO - 'PWD': '/builds/slave/test', 07:16:05 INFO - 'SHELL': '/bin/bash', 07:16:05 INFO - 'SHLVL': '1', 07:16:05 INFO - 'TERM': 'linux', 07:16:05 INFO - 'TMOUT': '86400', 07:16:05 INFO - 'USER': 'cltbld', 07:16:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:05 INFO - '_': '/tools/buildbot/bin/python'} 07:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 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)) 07:16:05 INFO - Cleaning up... 07:16:05 INFO - Return code: 0 07:16:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:05 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:16:05 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 07:16:05 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 07:16:05 INFO - Using env: {'DISPLAY': ':0', 07:16:05 INFO - 'HOME': '/home/cltbld', 07:16:05 INFO - 'LANG': 'en_US.UTF-8', 07:16:05 INFO - 'LANGUAGE': 'en_US:en', 07:16:05 INFO - 'LOGNAME': 'cltbld', 07:16:05 INFO - 'MAIL': '/var/mail/cltbld', 07:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:05 INFO - 'MOZ_NO_REMOTE': '1', 07:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:05 INFO - 'NO_EM_RESTART': '1', 07:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:05 INFO - 'PWD': '/builds/slave/test', 07:16:05 INFO - 'SHELL': '/bin/bash', 07:16:05 INFO - 'SHLVL': '1', 07:16:05 INFO - 'TERM': 'linux', 07:16:05 INFO - 'TMOUT': '86400', 07:16:05 INFO - 'USER': 'cltbld', 07:16:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:05 INFO - '_': '/tools/buildbot/bin/python'} 07:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:05 INFO - Downloading/unpacking jsonschema 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:07 INFO - Downloading/unpacking functools32 (from jsonschema) 07:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:07 INFO - warning: no files found matching '*.txt' 07:16:07 INFO - no previously-included directories found matching 'build' 07:16:07 INFO - no previously-included directories found matching 'dist' 07:16:07 INFO - no previously-included directories found matching '.git*' 07:16:07 INFO - Installing collected packages: jsonschema, functools32 07:16:07 INFO - Running setup.py install for functools32 07:16:07 INFO - warning: no files found matching '*.txt' 07:16:07 INFO - no previously-included directories found matching 'build' 07:16:07 INFO - no previously-included directories found matching 'dist' 07:16:07 INFO - no previously-included directories found matching '.git*' 07:16:07 INFO - Successfully installed jsonschema functools32 07:16:07 INFO - Cleaning up... 07:16:08 INFO - Return code: 0 07:16:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:16:08 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')]} 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:08 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')]} 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:08 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 0x7f64ce35bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', '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 07:16:08 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 07:16:08 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 07:16:08 INFO - Using env: {'DISPLAY': ':0', 07:16:08 INFO - 'HOME': '/home/cltbld', 07:16:08 INFO - 'LANG': 'en_US.UTF-8', 07:16:08 INFO - 'LANGUAGE': 'en_US:en', 07:16:08 INFO - 'LOGNAME': 'cltbld', 07:16:08 INFO - 'MAIL': '/var/mail/cltbld', 07:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:08 INFO - 'MOZ_NO_REMOTE': '1', 07:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:08 INFO - 'NO_EM_RESTART': '1', 07:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:08 INFO - 'PWD': '/builds/slave/test', 07:16:08 INFO - 'SHELL': '/bin/bash', 07:16:08 INFO - 'SHLVL': '1', 07:16:08 INFO - 'TERM': 'linux', 07:16:08 INFO - 'TMOUT': '86400', 07:16:08 INFO - 'USER': 'cltbld', 07:16:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:08 INFO - '_': '/tools/buildbot/bin/python'} 07:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:08 INFO - Downloading/unpacking flake8 07:16:08 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 07:16:08 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 07:16:08 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 07:16:08 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 07:16:08 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 07:16:08 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 07:16:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:16:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:16:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 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 07:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:10 INFO - no previously-included directories found matching 'docs/_build' 07:16:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:16:10 INFO - Running setup.py install for pep8 07:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:10 INFO - no previously-included directories found matching 'docs/_build' 07:16:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:16:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:16:11 INFO - Cleaning up... 07:16:11 INFO - Return code: 0 07:16:11 INFO - Running post-action listener: _resource_record_post_action 07:16:11 INFO - Running post-action listener: _start_resource_monitoring 07:16:11 INFO - Starting resource monitoring. 07:16:11 INFO - ##### 07:16:11 INFO - ##### Running install step. 07:16:11 INFO - ##### 07:16:11 INFO - Running pre-action listener: _resource_record_pre_action 07:16:11 INFO - Running main action method: install 07:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:11 INFO - Reading from file tmpfile_stdout 07:16:11 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:11 INFO - Reading from file tmpfile_stdout 07:16:11 INFO - Output received: 07:16:11 INFO - Usage: mozinstall [options] installer 07:16:11 INFO - Options: 07:16:11 INFO - -h, --help show this help message and exit 07:16:11 INFO - -d DEST, --destination=DEST 07:16:11 INFO - Directory to install application into. [default: 07:16:11 INFO - "/builds/slave/test"] 07:16:11 INFO - --app=APP Application being installed. [default: firefox] 07:16:11 INFO - mkdir: /builds/slave/test/build/application 07:16:11 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'] 07:16:11 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 07:16:27 INFO - Reading from file tmpfile_stdout 07:16:27 INFO - Output received: 07:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:27 INFO - Running post-action listener: _resource_record_post_action 07:16:27 INFO - ##### 07:16:27 INFO - ##### Running run-tests step. 07:16:27 INFO - ##### 07:16:27 INFO - Running pre-action listener: _resource_record_pre_action 07:16:27 INFO - Running main action method: run_tests 07:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:27 INFO - Python 2.7.3 07:16:27 INFO - Return code: 0 07:16:27 INFO - grabbing minidump binary from tooltool 07:16:27 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')]} 07:16:27 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 0xfc4410>, '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 0xfc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:27 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 07:16:27 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 07:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:27 INFO - Return code: 0 07:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:16:28 INFO - Return code: 0 07:16:28 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/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:16:28 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/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 07:16:28 INFO - Using env: {'DISPLAY': ':0', 07:16:28 INFO - 'HOME': '/home/cltbld', 07:16:28 INFO - 'LANG': 'en_US.UTF-8', 07:16:28 INFO - 'LANGUAGE': 'en_US:en', 07:16:28 INFO - 'LOGNAME': 'cltbld', 07:16:28 INFO - 'MAIL': '/var/mail/cltbld', 07:16:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:28 INFO - 'MOZ_NO_REMOTE': '1', 07:16:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:28 INFO - 'NO_EM_RESTART': '1', 07:16:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:28 INFO - 'PWD': '/builds/slave/test', 07:16:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:28 INFO - 'SHELL': '/bin/bash', 07:16:28 INFO - 'SHLVL': '1', 07:16:28 INFO - 'TERM': 'linux', 07:16:28 INFO - 'TMOUT': '86400', 07:16:28 INFO - 'USER': 'cltbld', 07:16:28 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775', 07:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:28 INFO - '_': '/tools/buildbot/bin/python'} 07:16:28 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/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:16:28 INFO - mozversion application_buildid: 20160421063405 07:16:28 INFO - mozversion application_changeset: 4ac3b4265ce2205bab28de9f09da31379e23b785 07:16:28 INFO - mozversion application_display_name: Nightly 07:16:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:28 INFO - mozversion application_name: Firefox 07:16:28 INFO - mozversion application_remotingname: firefox 07:16:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:16:28 INFO - mozversion application_vendor: Mozilla 07:16:28 INFO - mozversion application_version: 48.0a1 07:16:28 INFO - mozversion platform_buildid: 20160421063405 07:16:28 INFO - mozversion platform_changeset: 4ac3b4265ce2205bab28de9f09da31379e23b785 07:16:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:16:28 INFO - mozversion platform_version: 48.0a1 07:16:28 INFO - using testdate: 1461248188 07:16:28 INFO - actual date: 1461248188 07:16:28 INFO - starting webserver on 'localhost:41915' 07:16:28 INFO - SUITE-START | Running 2 tests 07:16:28 INFO - TEST-START | dromaeo_css 07:16:28 INFO - operating with platform_type : linux_ 07:16:28 INFO - Initialising browser for dromaeo_css test... 07:16:28 INFO - TEST-INFO | started process 28386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWlFcI/profile http://localhost:41915/getInfo.html) 07:16:32 INFO - PROCESS | 28386 | __metrics Screen width/height:1600/1200 07:16:32 INFO - PROCESS | 28386 | colorDepth:24 07:16:32 INFO - PROCESS | 28386 | Browser inner width/height: 1024/697 07:16:32 INFO - PROCESS | 28386 | __metrics 07:16:34 ERROR - PROCESS | 28386 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:16:35 INFO - TEST-INFO | 28386: exit 0 07:16:35 INFO - Browser initialized. 07:16:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:35 INFO - TEST-INFO | started process 28467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWlFcI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:46 INFO - PROCESS | 28467 | RSS: Main: 154939392 07:16:46 INFO - PROCESS | 28467 | 07:17:38 INFO - PROCESS | 28467 | 1461248258477 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] 07:19:49 INFO - PROCESS | 28467 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41915/tests/dromaeo/cssquery-ext.html) 07:19:50 INFO - PROCESS | 28467 | RSS: Main: 265195520 07:19:50 INFO - PROCESS | 28467 | 07:22:53 INFO - PROCESS | 28467 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-ext.html (next: http://localhost:41915/tests/dromaeo/cssquery-jquery.html) 07:22:54 INFO - PROCESS | 28467 | RSS: Main: 243699712 07:22:54 INFO - PROCESS | 28467 | 07:25:56 INFO - PROCESS | 28467 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41915/tests/dromaeo/cssquery-mootools.html) 07:25:57 INFO - PROCESS | 28467 | RSS: Main: 239042560 07:25:57 INFO - PROCESS | 28467 | 07:28:59 INFO - PROCESS | 28467 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41915/tests/dromaeo/cssquery-prototype.html) 07:28:59 INFO - PROCESS | 28467 | RSS: Main: 233324544 07:28:59 INFO - PROCESS | 28467 | 07:32:02 INFO - PROCESS | 28467 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41915/tests/dromaeo/cssquery-yui.html) 07:32:03 INFO - PROCESS | 28467 | RSS: Main: 210878464 07:32:03 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-yui.html (next: http://localhost:41915/tests/dromaeo/cssquery-dojo.html) 07:35:06 INFO - PROCESS | 28467 | RSS: Main: 315326464 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | __start_tp_report 07:35:06 INFO - PROCESS | 28467 | _x_x_mozilla_page_load 07:35:06 INFO - PROCESS | 28467 | _x_x_mozilla_page_load_details 07:35:06 INFO - PROCESS | 28467 | |i|pagename|runs| 07:35:06 INFO - PROCESS | 28467 | |0;dojo.html;2577.7035640901295;2609.8042646801473;2642.907498237562;2650.8542030188332;2650.867456627168;4531.456225252974;4578.954210457894;4605.654575906804;4606.700564463312;4629.282461218512;4602.516735742749;4655.208614535529;4693.037927224919;4712.434507859061;4723.787429565669;4252.107057517925;4268.850590229343;4310.956890431103;4330.718503297291;4403.273459879132;4285.314349704048;4309.37514060461;4365.80353884076;4399.208142534342;4403.801828917706;4160.646345060673;4317.287647538153;4356.8257269709175;4370.104128653635;4375.2124617568825;4186.937195942063;4193.664506839476;4236.872893813191;4266.296061149907;4327.415798867144;4208.263553878059;4216.325387937915;4227.598378154071;4262.062346283813;4267.146570685844;4362.323839804835;4499.032707967803;4505.43682039745;4513.887152821173;4541.159885421174;4960.107180707471;5012.1980483122525;5016.698998060128;5050.39395272566;5066.620003499752;4970.676906001135;4982.90034199314;4985.252212168168;4999.150144475448;5053.797848086072;4497.347884556721;4637.466691330473;4673.322368256618;4674.041821426667;4674.32222327764;5054.140796064605;5059.494050594984;5063.822766203165;5095.414027386824;5119.923201151985;4850.466448690641;4857.635677324215;4859.052484765508;4864.6594738368685;4911.877203069952;4777.976110119496;4895.853124406202;4942.1104201244125;4972.4033116025585;4990.600751939909;4833.299171620095;4838.225883858566;4847.151748444008;4897.657163998486;4913.778879950411;4826.32431459596;4827.155247831615;4829.710217386968;4850.80596776125;4881.585065269421;3988.142549351903;4048.7570745755347;4078.347464405681;4084.81618327176;4123.60825721556;3593.7749083372914;3600.963990360115;3644.362236608583;3645.3985092459448;3662.066173125836;4292.420523229386;4293.74237545742;4293.742375457483;4295.226859165317;4338.544452832407;4817.470078291385;4923.606111511071;4944.035912996931;4994.750262486861;4998.800047998112;4255.3616957456625;4271.402003719481;4277.679174061957;4281.721688090264;4315.482142142963;4428.092241090569;4429.247028005247;4432.246518091868;4475.172093162711;4476.395686582335;4572.0627271409285;4691.967767091234;4741.407324084489;4761.1429942609275;4771.427428708438;4882.4629290777275;4905.533974272438;4905.656604037826;4907.803687852589;4952.678075925198;4534.863954081383;4696.201645720304;4703.223968045234;4707.17624415719;4749.952500474951;4876.926846097383;4956.6530342877095;4960.057589058068;4963.801447942042;4969.35398398206;4953.133201689762;4960.553550180501;4961.7519124044375;4968.801247950186;5004.299398084198;4813.3983252093485;4818.759062046814;4824.638152138534;4828.517148285144;4839.516048395132;4711.222648263135;4784.64115191369;4826.6621336506105;4861.805527778849;4873.829415970424;4735.408073990751;4736.218523943511;4738.360321356573;4744.074905393553;4775.6418268629295;4843.491433399583;4843.878903027312;4844.0554091953145;4847.248676455155;4897.853064408074;4581.633469322513;4674.392328997209;4784.234522476387;4860.052289803454;4862.4651288357545 07:35:06 INFO - PROCESS | 28467 | |1;ext.html;563.7660370946057;582.6911736779508;583.2330485411684;587.9088741245104;606.8877257707325;33557.328853422914;34594.135146621345;34619;34632.307353852906;34649.48025779609;36591.45112823303;37199.44200836983;37404.625953740455;37430.62569374305;37502.812485937604;7156.928430715679;7591.924080759204;7814.101378341478;7827.217278272185;9419.670311539097;9581.568829402659;9731.075547822946;9742.659006934759;9747.025297470267;9750;9686.273529485281;9742.659006934759;9751.756206094833;9758.707238782812;9774.609015639366;7410.444216683743;7688.6155692215725;7692.153863075057;7696.307332340116;9672.468014259213;9639.228861691048;10061.849072263922;10088.848667269996;10101.343412678227;10104.292699511037;34086.31827363439;34703.479447808306;34762.82618586916;34771.478427823604;34819.303613927834;3071.1861356740483;3296.175956010997;3334.1992726109943;3725.4225595032813;3897.6686981606313;26393.736062639513;26897;26967.190984270503;28678;28730.856345718348;3447.5518182636347;3485.7734247273847;3625.782453052825;3637.418013117915;3638.181409182939;231641;232358.8382058096;232364;232952;233045;34008.65991340105;54817;54869.45130548644;55277.447225528034;55286.447135528935;33311.50032749462;33353;33475;33487.497687534706;33530.66469335275;12829.358532073358;13000.049992501012;13012.479500819862;13019.739605207842;13020.869791301966;9415.952920235355;10211.132053775364;10541.525631346607;10554;10567.788644227072;7990.081140668781;8004.279614834692;8078.35373170145;8119.147489513634;8158.551279679675;3146;3177.2851108500404;3201.295714942709;3213.742900567949;3256.2836176041706;938.6245501799335;961.2982522758425;991.1723710701644;1017.97455063624;1026.373911913732;28365.71634283631;28755.712442875723;28957.841686332733;29103.272418189714;29356.706432935825;959.4770849886828;985.679654112402;988.5255077562811;1000.8248556502583;1064.7125276175543;14641.48754793577;15165.165915874511;15266.770998435033;15428.845711542965;15601.297941592655;342421;369923;382550;383090;384693;48461.27308090381;49270.75364623154;49625.50374496209;49670.50329496731;49695;1224.706070543081;1238.0405185980937;1248.2822377133184;1250.1623911978813;1318.6637407461037;27635.4729054194;28987.85506072456;29167.270818229714;29651;29938;42352.364714529926;42778.57221427746;43059;43136.35295470508;43190;324360;325886;326618;326896;328382;22053.889730551888;22629;22785.430364241027;25168.49663006693;25639.743602564482;36279;36888.63111368852;37001.814990924875;37232.81383593065;37359.626403735616;32344.514832278004;34702.93343922152;35269.82365088158;35353.46969795404;35546.64453355433;33427.164320892174;33704.66295337015;34530.136746581535;34614.480782788785;34718.82640586781;33471.83264083664;33730.494042589875;34153.829230853684;34372.48441273433;34442;28784.280392990342;31079;31217.219569510944;31233;31236.37527249488;24292.271231863073;24515.509689806462;24558.263252102464;24840.254792355536;24855.254342369757 07:35:06 INFO - PROCESS | 28467 | |2;jquery.html;360.5403111033432;363.60185596771544;370.60160327647776;374.7152164355091;383.5340061824882;15765.448209312677;16630.417935372265;17813.73279400807;17863.46409607714;17867.821321786778;16313.510594682179;16360.754588681179;17398.565035874108;17398.82601173988;17425.738613920803;5022.497750224976;5150.356205474316;5175.275461435402;5177.404598471167;5179.507946745053;3684.1894783147663;3876.8061596920184;5110.616703747215;5595.21666966625;5938.88122237555;5833.183354330397;5864.882702345951;5895.410458954113;5896.498797602209;5902.321233058189;5656.660600363971;5877.970610146965;5890.97054514729;5891.440313170264;5901.203337549418;3319.286353434023;4884.7069175849565;5134.358205224347;5135.87160320995;5138;19239.653224274167;19259.22963081489;19277.325293614656;20620.79379206204;20641.690374644393;1843.060039379926;1907.16084922635;1937.2832052140657;2078.4401725384687;2489.73023757883;8470.957645211734;9119.088091190893;9190.264778817746;9391.389559678599;12986.610401687965;1760.5334586334632;1789.6845818323523;1791.7133258678548;1818.6180902010594;1852.3331600623765;62976.37023629751;65492.67253663749;66507;66630.33369666242;67238.32761672369;9627.90372096284;9742.512874356396;9908.851367229354;9917.068600576073;10162.085412312927;12960.222386656831;13047.347632618332;13053.673658158432;13086.672833179056;13099.2140471572;6944.618046007518;6949.583025018515;7074.089995701132;7092.361687448154;7098.609576473344;6539.2479864815205;6634.933650663432;6696.363845434676;6710.731570737214;6751.0886030386255;4104.0970986382945;4126.42230087788;4170.249355116108;4207.8316867325575;4219.050713589418;1705.6844483770542;1773.6364045370926;1776.6801975644507;1824.5954276271943;1845.2526726675717;832.6419639554929;853.799357151069;866.6706651472526;879.5294517433271;896.8699538567001;15892.284847181905;16423.67152656964;16577.91711041437;16795.2442140104;16922.40771572989;885.6811547842772;892.5001998880648;905.7690288976269;908.2688435809237;932.6409332407072;9204.263658907405;9324.720258392259;9535.761605959768;9558.378705384128;9591.328606997582;393378;393676;398847;405523;407468;72962.63518682373;73068;74158;74634.62682686551;74831.62584187153;926.1942110364026;945.4894357047255;959.7792507723262;960.8606752020918;962.2686758063921;14709.190994495406;14775.408983640964;14868.479603213835;14944.476943306932;15259.160746159068;32083.679163208068;32431.35137297288;33174.17064573309;33490.497642534894;33634.49548256729;45722.77138614286;45804.48075355888;45845.31232031455;46007.53992460033;46344;7765.22347765219;7893.284543063481;7898.2891539761695;7950.761477155464;8014.479058861389;8742.519161446182;10840.753313369063;11604.825927610924;11712.590059347882;11876.408911536364;10480.68557943263;10500.697147940242;10530.104941080093;10545.630902918361;10627.256092073481;10095;10239.7440063999;10442.060214580724;10452.895471045193;10519.737006574896;10237.283390162616;10290.073893349634;10486.423246721199;10643.860061281786;10797.974192451704;7671.884921726067;7772.45592808498;7947.602619869099;7976.042874855055;8173.79565510867;9532.90467095348;10342.896571034495;10344.948275258575;10400.843987340348;10471.3193642413 07:35:06 INFO - PROCESS | 28467 | |3;mootools.html;1221.9022478201746;1421.2893553223385;1455.8908081893858;1582.9683406331874;1773.7516747655322;6455.193100862392;7156.248593897637;7346.4122870170395;7362.705491780336;7411.814704632387;7122.8575428491395;7197.856042879139;7215.639218039103;7238.891416628755;7267.23694012129;1876.6246750649857;2121.109134163651;2151.9569608607817;2157.1263638226465;2223.3663405929315;2165.2854557995825;2176.2383165891893;2184.170015394156;2184.2464349799293;2184.8798316092607;2113.123053932624;2158.9784102158933;2161.3948094533557;2161.7513985891665;2161.8378621603365;1888.792232854385;2134.402367337148;2201.3506015725397;2202.559488102386;2205.514786746913;2088.258668172792;2102.3482720356737;2106.568153528523;2108.6731556608597;2110.6095372356162;7296.124465064173;7296.270372962715;7328.523645962995;7368.115826100902;7370.336669699753;4208.3687446882905;4319.114581510814;4322.654187664979;4362.629176519999;4372.519022907478;2818.873150708223;2868.3259434033193;2893.6238289022504;2897.130860741769;2931.721486458783;917.651292508849;926.8285367207088;940.3370623710337;955.2787645327733;957.7270477913761;9842.80314393708;9875.555599998017;9895.554700038516;10015.499225038719;10037.749056273651;3975.1254723960683;4047.494063242095;4146.460960075171;4189.664826813848;4191.266528357525;8530.10433904431;8552.40133190683;8555.572221388906;8563.614637341334;8575.571221439028;3888;4474.194644963938;4478.843240486633;4498.257787465097;4505.81976720934;3988.282109220368;4071.4707088078953;4072.3687828386646;4072.775997320176;4117.56765539614;3526.2947410518;3556.78659280444;3623.7644553103964;3632.54593175853;3669.9816500917323;1192.952281908714;1211.618340222827;1214.7023979125172;1222.2910711787142;1225.497546006151;799.192815256595;853.8164294676675;882.7660669922476;890.283321925843;902.7111324376268;5261.789528418821;5296.9141326028075;5315.920261196085;5499.092649712833;5506.779728810803;903.5708038681573;933.0622724162174;936.8782058332373;938.474454305591;941.3034354577563;3709.239605880788;3791.2227993261317;3796.487474191004;3820.2550502651716;3850.7111966602056;8483.278921291636;8541.701040463555;8880.822383552293;8881.866771998426;8908.331875109392;8686.6525338987;8737.868931966026;8742.431741936754;8774.649014039494;8816.162464565856;6833.214180369222;6867.141607299088;6964.860702785916;6988.126484189476;6989.091418115714;5184.300119483822;5268.157094864803;5270.920936186037;5281.049411106038;5364.544013758874;8250.834983300181;8319.625616847377;8419.789505262417;8486.236238738544;8488.957555212184;8462;8481.151884811716;8618.65525379003;8622.78443038929;8681.522516261666;5715.399883012224;6083.939160608337;6223.782167624111;6287.779927702509;6400.231972163184;7122.145342558926;7202.71189152449;7256.1655409628565;7276.745313913988;7291.890621640786;6510.153680021756;6553.344665533408;6588.8023359299295;6601.834954125993;6777.051212830109;6588.8023359299295;6624.701888414937;6657.1345725055435;6692.230393504809;6698.933010670026;6347.587406818542;6388.275165705327;6394.296627370893;6395.744170233139;6400.103985441949;4295.334223195409;4441.37820705108;4474.776261186993;4541.250693635513;4636.953630463652;4631.166390049823;4657.6506761992305;4695.6243500519195;4734.905301894012;4762.690425122356 07:35:06 INFO - PROCESS | 28467 | |4;prototype.html;293.56259173830983;302.40275455974444;304.885667874547;313.59859379993617;315.2198309184768;4941.184704523749;5099.235114732792;5132.101882170619;5202.921956170656;5213.08770965081;4875.146849301375;5049.39407271127;5101.311322971398;5132.769025393857;5142.922856157152;3994.600539945997;3999.740016898907;4005.8597949071786;4009.9599004010024;4011.8595849145286;3775.8112094395306;3816.255830113129;3958.7228893977435;3996.880873355465;4019.5980401959714;3941.60583941605;3952.347862602667;3982.1040265940223;3988.421678856564;4007.7394969327047;3985.561588225293;4001.8199181036775;4004.3793212051887;4005.2790497710403;4015.959840401588;3475.739319551044;3539.0975301298004;3539.876104336336;3548.2436194083834;3558.839852206657;4912.459629440758;4918.631102667278;4919.950800491985;4939.728314942677;4942.159832828428;4582.221022426163;4586.678932474728;4588.24293991491;4609.608183304423;4612.423447069116;5192.92210616841;5371.328583927009;5385.542228910547;5394.271773310592;5402.459754024605;3847.8653247136217;3863.536375634914;3865.91754308794;3868.1103346230243;3868.18768058708;5573.777048918038;5617.606767526275;5630.5495560355075;5639.605227634067;5665.263515742969;3955.367141257385;3956.287868183697;3957.248122856648;3960.1881614269005;3963.623455771697;3669.1744357519347;3870.1679138985255;3880.835749275206;3891.2606604745006;4021.6782657387926;4427.380166776654;4453.064856380196;4461.977690111528;4468.352088947085;4484.192845287815;5356.330458692663;5362.034833729966;5369.5167434931045;5379.327584051994;5384.246205531229;1274.20362273579;1282.602393258093;1298.7597294500358;1307.8561358250586;1314.572763851752;900.203320061737;903.6972614174325;916.2532535983153;916.4684482999844;925.1488630459993;4736.786844592001;4742.762861856893;4745.454272758677;4746.430428348551;4748.216544270226;5444.156155795858;5455.454454554592;5459.727013649302;5472.863178420492;5478.150886612581;4781.808727650855;4781.808727650925;4782;4787.210110331756;4790.7365094920115;2933.530635098374;2938.5445255985355;2953.3059730963205;2960.304328482805;2962.5408061750463;4975.776090075955;5084.3644544431945;5164.948350516522;5197.870053248624;5243.2659427680155;5588.385277619459;5723.910772567982;5736.225609542658;5743.396943320891;5754.88490230193;5204.869878253074;5292.761825717852;5302.469753024821;5308.336457942757;5318.867028324323;5550.250716153268;5588.804391846266;5591.440855914376;5596.608237423341;5614.410486898817;5447.673139611636;5449.509544141047;5461.972690136524;5485.122380419273;5485.753141108739;5072.315237443046;5332.9466705334;5341.839744807662;5375.489328513785;5383.5962302826665;3872.6708229800784;3879.9224015518967;3898.577019387846;3906.3554513504955;3911.1786524830104;5669.234653321913;5671.6029877909805;5671.773129074791;5680.9147862781265;5690.516306113861;5378.220158077135;5478.150886612581;5482.150266708666;5489.560835133259;5500.42245564226;5465.726713664221;5468;5475.972620136874;5477.75350109254;5478.287822583198;5367.892642147213;5377.892442151213;5383.461653834585;5383.623146379716;5391.7304134793885;5280.86797830042;5454.181872718965;5505.366882808528;5518.834434966958;5520.365158006881;5350.759215835219;5360.249565060816;5371.543418809445;5371.62398632092;5373.2746079278795 07:35:06 INFO - PROCESS | 28467 | |5;yui.html;676.8003438985498;726.2156870579774;755.5693254844738;775.7129861951072;791.540906274361;11513.827292590608;11744.765104697912;11879.70300742482;11884.049276057916;11900.880991190097;12173.756524869497;12796.552120675778;12804.615861524146;12808.295543745113;12810.615681529545;553.2475832867298;776.6233376812241;799.5442597719302;805.5810978291285;805.8025783682976;798.2695833312512;798.8002999250187;798.9201079892023;799.9080105787822;801.9478733882308;840.932725381968;842.6545116502235;843.3590471241839;843.7510934274374;844.1727107434717;648.2124219073825;813.4834380168577;827.2843989948711;828.6229765456764;836.0719601242616;608.996955015222;610.5787006965224;610.8289678889873;611.966341851198;615.6829232945037;12126.575569855013;12133.272003679807;12147.392630368446;12188.695282617917;12192.695182620417;11845.407729613486;12380.257184568954;12646.051546134076;12699;12783.5525756599;10837.620683276127;11153.163512736577;11401.714957126056;11420.42897855104;11551.133664975161;3240.4653232216656;3304.93390132196;3315.6187038490643;3389.9661003390142;3403.5745531808525;44519.554804452186;45580.999999999665;46144.3078353825;46647.30029049567;46891;9519.666811661558;9641.469719165514;9662.661806836726;9751.65869194589;9853.852192216978;17060.91469542669;17063.061531615633;17070.23183956725;17079.65840683204;17107.572310692332;6786.762463313859;6796.626185559743;6899.965500172467;7044.964775176194;7099.609521476368;3772.245550889833;3828.789416582059;3856.4986551748652;3868.7678739275734;3951.0122469382654;2797.4405118976288;2843.616111824877;2856.0860524631917;2858.3568697043415;2859.7998140130408;413.2643893868918;471.3660127129006;485.0928763212744;487.8365747474636;523.602062432554;575.2234483447396;632.7627139822566;643.4369926314475;659.0838734159522;661.4080398043724;7325.4139668826365;7471.178170401252;7647.541147531166;7690.500117492345;8082.313003394777;537.247853005795;580.5848818095083;583.6789765628972;663.5653646861314;666.2926424808711;3817.3128836809087;3840.231953609289;3881.437191607258;3935.626115519021;4038.495188101487;48389.27416088691;48789.512104879206;49417.50582494201;50029.249561255885;50180.498195018314;34214.82892585521;37571.06072348213;38811.41782873259;40695.59304406977;43569.78215108904;32652;33771.29829613625;34425.82787086099;39052.6094739049;39702.60297397047;7484.438667100098;8231.794205144919;8247.876281855657;8301.709440169565;8313.83372332562;27898.30254243579;28551.571726423706;28757.85621071881;28915.7108428913;29267.853660731562;35851.64148358483;36088.45867312045;36194.92343150757;36313;36791.8160409207;11237.55049797999;11304.217469518224;11443.14176436754;11468.139889508153;11489.080873530265;11995.700107497383;12267.938660306998;12347.75304493923;12385.876141238832;12386.132970691964;10721.892781072089;10835.783284334428;10848.566057357617;10937.835932460861;11263.66209013731;11374;11655.708607284885;11998.340091294713;12098.395080245777;12132.029437645144;11386.146039046938;11576.421178941187;12076.698082548006;12131.45408456604;12138.02895768354;9079.793790766329;9192.35653504275;9383.061693830563;9388.202002829836;9565.438171146357;9285.48929808867;10003.899961000297;10010.199184065403;10053.19574434058;10057 07:35:06 INFO - PROCESS | 28467 | __end_tp_report 07:35:06 INFO - PROCESS | 28467 | __start_cc_report 07:35:06 INFO - PROCESS | 28467 | _x_x_mozilla_cycle_collect,980 07:35:06 INFO - PROCESS | 28467 | __end_cc_report 07:35:06 INFO - PROCESS | 28467 | __startTimestamp1461249306546__endTimestamp 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | ------- Summary: start ------- 07:35:06 INFO - PROCESS | 28467 | Number of tests: 6 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | [#0] dojo.html Cycles:165 Average:4573.50 Median:4712.43 stddev:476.57 (10.1%) stddev-sans-first:451.58 07:35:06 INFO - PROCESS | 28467 | Values: 2577.7 2609.8 2642.9 2650.9 2650.9 4531.5 4579.0 4605.7 4606.7 4629.3 4602.5 4655.2 4693.0 4712.4 4723.8 4252.1 4268.9 4311.0 4330.7 4403.3 4285.3 4309.4 4365.8 4399.2 4403.8 4160.6 4317.3 4356.8 4370.1 4375.2 4186.9 4193.7 4236.9 4266.3 4327.4 4208.3 4216.3 4227.6 4262.1 4267.1 4362.3 4499.0 4505.4 4513.9 4541.2 4960.1 5012.2 5016.7 5050.4 5066.6 4970.7 4982.9 4985.3 4999.2 5053.8 4497.3 4637.5 4673.3 4674.0 4674.3 5054.1 5059.5 5063.8 5095.4 5119.9 4850.5 4857.6 4859.1 4864.7 4911.9 4778.0 4895.9 4942.1 4972.4 4990.6 4833.3 4838.2 4847.2 4897.7 4913.8 4826.3 4827.2 4829.7 4850.8 4881.6 3988.1 4048.8 4078.3 4084.8 4123.6 3593.8 3601.0 3644.4 3645.4 3662.1 4292.4 4293.7 4293.7 4295.2 4338.5 4817.5 4923.6 4944.0 4994.8 4998.8 4255.4 4271.4 4277.7 4281.7 4315.5 4428.1 4429.2 4432.2 4475.2 4476.4 4572.1 4692.0 4741.4 4761.1 4771.4 4882.5 4905.5 4905.7 4907.8 4952.7 4534.9 4696.2 4703.2 4707.2 4750.0 4876.9 4956.7 4960.1 4963.8 4969.4 4953.1 4960.6 4961.8 4968.8 5004.3 4813.4 4818.8 4824.6 4828.5 4839.5 4711.2 4784.6 4826.7 4861.8 4873.8 4735.4 4736.2 4738.4 4744.1 4775.6 4843.5 4843.9 4844.1 4847.2 4897.9 4581.6 4674.4 4784.2 4860.1 4862.5 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | [#1] ext.html Cycles:180 Average:45127.39 Median:34407.24 stddev:83334.91 (242.2%) stddev-sans-first:83501.51 07:35:06 INFO - PROCESS | 28467 | Values: 563.8 582.7 583.2 587.9 606.9 33557.3 34594.1 34619.0 34632.3 34649.5 36591.5 37199.4 37404.6 37430.6 37502.8 7156.9 7591.9 7814.1 7827.2 9419.7 9581.6 9731.1 9742.7 9747.0 9750.0 9686.3 9742.7 9751.8 9758.7 9774.6 7410.4 7688.6 7692.2 7696.3 9672.5 9639.2 10061.8 10088.8 10101.3 10104.3 34086.3 34703.5 34762.8 34771.5 34819.3 3071.2 3296.2 3334.2 3725.4 3897.7 26393.7 26897.0 26967.2 28678.0 28730.9 3447.6 3485.8 3625.8 3637.4 3638.2 231641.0 232358.8 232364.0 232952.0 233045.0 34008.7 54817.0 54869.5 55277.4 55286.4 33311.5 33353.0 33475.0 33487.5 33530.7 12829.4 13000.0 13012.5 13019.7 13020.9 9416.0 10211.1 10541.5 10554.0 10567.8 7990.1 8004.3 8078.4 8119.1 8158.6 3146.0 3177.3 3201.3 3213.7 3256.3 938.6 961.3 991.2 1018.0 1026.4 28365.7 28755.7 28957.8 29103.3 29356.7 959.5 985.7 988.5 1000.8 1064.7 14641.5 15165.2 15266.8 15428.8 15601.3 342421.0 369923.0 382550.0 383090.0 384693.0 48461.3 49270.8 49625.5 49670.5 49695.0 1224.7 1238.0 1248.3 1250.2 1318.7 27635.5 28987.9 29167.3 29651.0 29938.0 42352.4 42778.6 43059.0 43136.4 43190.0 324360.0 325886.0 326618.0 326896.0 328382.0 22053.9 22629.0 22785.4 25168.5 25639.7 36279.0 36888.6 37001.8 37232.8 37359.6 32344.5 34702.9 35269.8 35353.5 35546.6 33427.2 33704.7 34530.1 34614.5 34718.8 33471.8 33730.5 34153.8 34372.5 34442.0 28784.3 31079.0 31217.2 31233.0 31236.4 24292.3 24515.5 24558.3 24840.3 24855.3 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | [#2] jquery.html Cycles:180 Average:24093.81 Median:4189.04 stddev:65762.81 (1569.9%) stddev-sans-first:65923.15 07:35:06 INFO - PROCESS | 28467 | Values: 360.5 363.6 370.6 374.7 383.5 15765.4 16630.4 17813.7 17863.5 17867.8 16313.5 16360.8 17398.6 17398.8 17425.7 5022.5 5150.4 5175.3 5177.4 5179.5 3684.2 3876.8 5110.6 5595.2 5938.9 5833.2 5864.9 5895.4 5896.5 5902.3 5656.7 5878.0 5891.0 5891.4 5901.2 3319.3 4884.7 5134.4 5135.9 5138.0 19239.7 19259.2 19277.3 20620.8 20641.7 1843.1 1907.2 1937.3 2078.4 2489.7 8471.0 9119.1 9190.3 9391.4 12986.6 1760.5 1789.7 1791.7 1818.6 1852.3 62976.4 65492.7 66507.0 66630.3 67238.3 9627.9 9742.5 9908.9 9917.1 10162.1 12960.2 13047.3 13053.7 13086.7 13099.2 6944.6 6949.6 7074.1 7092.4 7098.6 6539.2 6634.9 6696.4 6710.7 6751.1 4104.1 4126.4 4170.2 4207.8 4219.1 1705.7 1773.6 1776.7 1824.6 1845.3 832.6 853.8 866.7 879.5 896.9 15892.3 16423.7 16577.9 16795.2 16922.4 885.7 892.5 905.8 908.3 932.6 9204.3 9324.7 9535.8 9558.4 9591.3 393378.0 393676.0 398847.0 405523.0 407468.0 72962.6 73068.0 74158.0 74634.6 74831.6 926.2 945.5 959.8 960.9 962.3 14709.2 14775.4 14868.5 14944.5 15259.2 32083.7 32431.4 33174.2 33490.5 33634.5 45722.8 45804.5 45845.3 46007.5 46344.0 7765.2 7893.3 7898.3 7950.8 8014.5 8742.5 10840.8 11604.8 11712.6 11876.4 10480.7 10500.7 10530.1 10545.6 10627.3 10095.0 10239.7 10442.1 10452.9 10519.7 10237.3 10290.1 10486.4 10643.9 10798.0 7671.9 7772.5 7947.6 7976.0 8173.8 9532.9 10342.9 10344.9 10400.8 10471.3 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | [#3] mootools.html Cycles:180 Average:4934.62 Median:5502.94 stddev:2645.96 (48.1%) stddev-sans-first:2638.67 07:35:06 INFO - PROCESS | 28467 | Values: 1221.9 1421.3 1455.9 1583.0 1773.8 6455.2 7156.2 7346.4 7362.7 7411.8 7122.9 7197.9 7215.6 7238.9 7267.2 1876.6 2121.1 2152.0 2157.1 2223.4 2165.3 2176.2 2184.2 2184.2 2184.9 2113.1 2159.0 2161.4 2161.8 2161.8 1888.8 2134.4 2201.4 2202.6 2205.5 2088.3 2102.3 2106.6 2108.7 2110.6 7296.1 7296.3 7328.5 7368.1 7370.3 4208.4 4319.1 4322.7 4362.6 4372.5 2818.9 2868.3 2893.6 2897.1 2931.7 917.7 926.8 940.3 955.3 957.7 9842.8 9875.6 9895.6 10015.5 10037.7 3975.1 4047.5 4146.5 4189.7 4191.3 8530.1 8552.4 8555.6 8563.6 8575.6 3888.0 4474.2 4478.8 4498.3 4505.8 3988.3 4071.5 4072.4 4072.8 4117.6 3526.3 3556.8 3623.8 3632.5 3670.0 1193.0 1211.6 1214.7 1222.3 1225.5 799.2 853.8 882.8 890.3 902.7 5261.8 5296.9 5315.9 5499.1 5506.8 903.6 933.1 936.9 938.5 941.3 3709.2 3791.2 3796.5 3820.3 3850.7 8483.3 8541.7 8880.8 8881.9 8908.3 8686.7 8737.9 8742.4 8774.6 8816.2 6833.2 6867.1 6964.9 6988.1 6989.1 5184.3 5268.2 5270.9 5281.0 5364.5 8250.8 8319.6 8419.8 8486.2 8489.0 8462.0 8481.2 8618.7 8622.8 8681.5 5715.4 6083.9 6223.8 6287.8 6400.2 7122.1 7202.7 7256.2 7276.7 7291.9 6510.2 6553.3 6588.8 6601.8 6777.1 6588.8 6624.7 6657.1 6692.2 6698.9 6347.6 6388.3 6394.3 6395.7 6400.1 4295.3 4441.4 4474.8 4541.3 4637.0 4631.2 4657.7 4695.6 4734.9 4762.7 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | [#4] prototype.html Cycles:180 Average:4479.70 Median:5091.80 stddev:1319.92 (25.9%) stddev-sans-first:1285.68 07:35:06 INFO - PROCESS | 28467 | Values: 293.6 302.4 304.9 313.6 315.2 4941.2 5099.2 5132.1 5202.9 5213.1 4875.1 5049.4 5101.3 5132.8 5142.9 3994.6 3999.7 4005.9 4010.0 4011.9 3775.8 3816.3 3958.7 3996.9 4019.6 3941.6 3952.3 3982.1 3988.4 4007.7 3985.6 4001.8 4004.4 4005.3 4016.0 3475.7 3539.1 3539.9 3548.2 3558.8 4912.5 4918.6 4920.0 4939.7 4942.2 4582.2 4586.7 4588.2 4609.6 4612.4 5192.9 5371.3 5385.5 5394.3 5402.5 3847.9 3863.5 3865.9 3868.1 3868.2 5573.8 5617.6 5630.5 5639.6 5665.3 3955.4 3956.3 3957.2 3960.2 3963.6 3669.2 3870.2 3880.8 3891.3 4021.7 4427.4 4453.1 4462.0 4468.4 4484.2 5356.3 5362.0 5369.5 5379.3 5384.2 1274.2 1282.6 1298.8 1307.9 1314.6 900.2 903.7 916.3 916.5 925.1 4736.8 4742.8 4745.5 4746.4 4748.2 5444.2 5455.5 5459.7 5472.9 5478.2 4781.8 4781.8 4782.0 4787.2 4790.7 2933.5 2938.5 2953.3 2960.3 2962.5 4975.8 5084.4 5164.9 5197.9 5243.3 5588.4 5723.9 5736.2 5743.4 5754.9 5204.9 5292.8 5302.5 5308.3 5318.9 5550.3 5588.8 5591.4 5596.6 5614.4 5447.7 5449.5 5462.0 5485.1 5485.8 5072.3 5332.9 5341.8 5375.5 5383.6 3872.7 3879.9 3898.6 3906.4 3911.2 5669.2 5671.6 5671.8 5680.9 5690.5 5378.2 5478.2 5482.2 5489.6 5500.4 5465.7 5468.0 5476.0 5477.8 5478.3 5367.9 5377.9 5383.5 5383.6 5391.7 5280.9 5454.2 5505.4 5518.8 5520.4 5350.8 5360.2 5371.5 5371.6 5373.3 07:35:06 INFO - PROCESS | 28467 | 07:35:06 INFO - PROCESS | 28467 | [#5] yui.html Cycles:180 Average:12295.56 Median:21346.43 stddev:13243.36 (62.0%) stddev-sans-first:13251.77 07:35:06 INFO - PROCESS | 28467 | Values: 676.8 726.2 755.6 775.7 791.5 11513.8 11744.8 11879.7 11884.0 11900.9 12173.8 12796.6 12804.6 12808.3 12810.6 553.2 776.6 799.5 805.6 805.8 798.3 798.8 798.9 799.9 801.9 840.9 842.7 843.4 843.8 844.2 648.2 813.5 827.3 828.6 836.1 609.0 610.6 610.8 612.0 615.7 12126.6 12133.3 12147.4 12188.7 12192.7 11845.4 12380.3 12646.1 12699.0 12783.6 10837.6 11153.2 11401.7 11420.4 11551.1 3240.5 3304.9 3315.6 3390.0 3403.6 44519.6 45581.0 46144.3 46647.3 46891.0 9519.7 9641.5 9662.7 9751.7 9853.9 17060.9 17063.1 17070.2 17079.7 17107.6 6786.8 6796.6 6900.0 7045.0 7099.6 3772.2 3828.8 3856.5 3868.8 3951.0 2797.4 2843.6 2856.1 2858.4 2859.8 413.3 471.4 485.1 487.8 523.6 575.2 632.8 643.4 659.1 661.4 7325.4 7471.2 7647.5 7690.5 8082.3 537.2 580.6 583.7 663.6 666.3 3817.3 3840.2 3881.4 3935.6 4038.5 48389.3 48789.5 49417.5 50029.2 50180.5 34214.8 37571.1 38811.4 40695.6 43569.8 32652.0 33771.3 34425.8 39052.6 39702.6 7484.4 8231.8 8247.9 8301.7 8313.8 27898.3 28551.6 28757.9 28915.7 29267.9 35851.6 36088.5 36194.9 36313.0 36791.8 11237.6 11304.2 11443.1 11468.1 11489.1 11995.7 12267.9 12347.8 12385.9 12386.1 10721.9 10835.8 10848.6 10937.8 11263.7 11374.0 11655.7 11998.3 12098.4 12132.0 11386.1 11576.4 12076.7 12131.5 12138.0 9079.8 9192.4 9383.1 9388.2 9565.4 9285.5 10003.9 10010.2 10053.2 10057.0 07:35:06 INFO - PROCESS | 28467 | -------- Summary: end -------- 07:35:06 INFO - PROCESS | 28467 | 07:35:07 INFO - TEST-INFO | 28467: exit 0 07:35:07 INFO - TEST-OK | dromaeo_css | took 1118944ms 07:35:07 INFO - TEST-START | kraken 07:35:07 INFO - operating with platform_type : linux_ 07:35:07 INFO - Initialising browser for kraken test... 07:35:07 INFO - TEST-INFO | started process 28685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwcSftG/profile http://localhost:41915/getInfo.html) 07:35:11 INFO - PROCESS | 28685 | __metrics Screen width/height:1600/1200 07:35:11 INFO - PROCESS | 28685 | colorDepth:24 07:35:11 INFO - PROCESS | 28685 | Browser inner width/height: 1024/697 07:35:11 INFO - PROCESS | 28685 | __metrics 07:35:12 ERROR - PROCESS | 28685 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:35:13 INFO - TEST-INFO | 28685: exit 0 07:35:13 INFO - Browser initialized. 07:35:13 INFO - Running cycle 1/1 for kraken test... 07:35:13 INFO - TEST-INFO | started process 28767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwcSftG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:25 INFO - PROCESS | 28767 | RSS: Main: 155557888 07:35:25 INFO - PROCESS | 28767 | 07:35:28 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:29 INFO - PROCESS | 28767 | RSS: Main: 210366464 07:35:29 INFO - PROCESS | 28767 | 07:35:31 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-dft) 07:35:32 INFO - PROCESS | 28767 | RSS: Main: 195735552 07:35:32 INFO - PROCESS | 28767 | 07:35:35 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-fft) 07:35:36 INFO - PROCESS | 28767 | RSS: Main: 266788864 07:35:36 INFO - PROCESS | 28767 | 07:35:38 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-oscillator) 07:35:39 INFO - PROCESS | 28767 | RSS: Main: 175124480 07:35:39 INFO - PROCESS | 28767 | 07:35:41 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:41 INFO - PROCESS | 28767 | RSS: Main: 178958336 07:35:41 INFO - PROCESS | 28767 | 07:35:45 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:45 INFO - PROCESS | 28767 | RSS: Main: 214753280 07:35:45 INFO - PROCESS | 28767 | 07:35:49 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:49 INFO - PROCESS | 28767 | RSS: Main: 213319680 07:35:49 INFO - PROCESS | 28767 | 07:35:52 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41915/tests/kraken/driver.html?testName=json-parse-financial) 07:35:53 INFO - PROCESS | 28767 | RSS: Main: 214372352 07:35:53 INFO - PROCESS | 28767 | 07:35:54 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:55 INFO - PROCESS | 28767 | RSS: Main: 202493952 07:35:55 INFO - PROCESS | 28767 | 07:35:57 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:58 INFO - PROCESS | 28767 | RSS: Main: 204144640 07:35:58 INFO - PROCESS | 28767 | 07:36:00 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:36:00 INFO - PROCESS | 28767 | RSS: Main: 219111424 07:36:00 INFO - PROCESS | 28767 | 07:36:03 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:04 INFO - PROCESS | 28767 | RSS: Main: 222736384 07:36:04 INFO - PROCESS | 28767 | 07:36:07 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:07 INFO - PROCESS | 28767 | RSS: Main: 216510464 07:36:07 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41915/tests/kraken/driver.html?testName=ai-astar) 07:36:09 INFO - PROCESS | 28767 | RSS: Main: 279560192 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | __start_tp_report 07:36:09 INFO - PROCESS | 28767 | _x_x_mozilla_page_load 07:36:09 INFO - PROCESS | 28767 | _x_x_mozilla_page_load_details 07:36:09 INFO - PROCESS | 28767 | |i|pagename|runs| 07:36:09 INFO - PROCESS | 28767 | |0;ai-astar;113;116;109;112;115;113;101;112;113;120 07:36:09 INFO - PROCESS | 28767 | |1;audio-beat-detection;156;143;173;198;134;160;163;139;188;136 07:36:09 INFO - PROCESS | 28767 | |2;audio-dft;161;159;161;161;161;160;160;162;160;162 07:36:09 INFO - PROCESS | 28767 | |3;audio-fft;75;77;110;108;75;76;76;127;101;73 07:36:09 INFO - PROCESS | 28767 | |4;audio-oscillator;95;94;142;93;93;95;143;94;94;147 07:36:09 INFO - PROCESS | 28767 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 07:36:09 INFO - PROCESS | 28767 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 07:36:09 INFO - PROCESS | 28767 | |7;imaging-desaturate;95;94;95;95;95;94;94;95;94;94 07:36:09 INFO - PROCESS | 28767 | |8;json-parse-financial;66;64;65;65;64;65;65;86;64;63 07:36:09 INFO - PROCESS | 28767 | |9;json-stringify-tinderbox;64;65;65;65;64;65;65;65;65;65 07:36:09 INFO - PROCESS | 28767 | |10;stanford-crypto-aes;79;79;81;79;80;81;79;88;80;79 07:36:09 INFO - PROCESS | 28767 | |11;stanford-crypto-ccm;135;133;137;133;131;138;134;133;172;134 07:36:09 INFO - PROCESS | 28767 | |12;stanford-crypto-pbkdf2;178;181;175;178;181;182;179;183;175;179 07:36:09 INFO - PROCESS | 28767 | |13;stanford-crypto-sha256-iterative;72;72;73;73;74;73;80;73;71;71 07:36:09 INFO - PROCESS | 28767 | __end_tp_report 07:36:09 INFO - PROCESS | 28767 | __start_cc_report 07:36:09 INFO - PROCESS | 28767 | _x_x_mozilla_cycle_collect,1834 07:36:09 INFO - PROCESS | 28767 | __end_cc_report 07:36:09 INFO - PROCESS | 28767 | __startTimestamp1461249369837__endTimestamp 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | ------- Summary: start ------- 07:36:09 INFO - PROCESS | 28767 | Number of tests: 14 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:4.95 (4.4%) stddev-sans-first:5.24 07:36:09 INFO - PROCESS | 28767 | Values: 113.0 116.0 109.0 112.0 115.0 113.0 101.0 112.0 113.0 120.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#1] audio-beat-detection Cycles:10 Average:159.00 Median:161.50 stddev:22.10 (13.7%) stddev-sans-first:23.41 07:36:09 INFO - PROCESS | 28767 | Values: 156.0 143.0 173.0 198.0 134.0 160.0 163.0 139.0 188.0 136.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:36:09 INFO - PROCESS | 28767 | Values: 161.0 159.0 161.0 161.0 161.0 160.0 160.0 162.0 160.0 162.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#3] audio-fft Cycles:10 Average:89.80 Median:75.00 stddev:19.76 (26.3%) stddev-sans-first:20.22 07:36:09 INFO - PROCESS | 28767 | Values: 75.0 77.0 110.0 108.0 75.0 76.0 76.0 127.0 101.0 73.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:24.19 (25.7%) stddev-sans-first:25.13 07:36:09 INFO - PROCESS | 28767 | Values: 95.0 94.0 142.0 93.0 93.0 95.0 143.0 94.0 94.0 147.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:36:09 INFO - PROCESS | 28767 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 07:36:09 INFO - PROCESS | 28767 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:36:09 INFO - PROCESS | 28767 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:65.00 stddev:6.83 (10.5%) stddev-sans-first:7.24 07:36:09 INFO - PROCESS | 28767 | Values: 66.0 64.0 65.0 65.0 64.0 65.0 65.0 86.0 64.0 63.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 07:36:09 INFO - PROCESS | 28767 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:2.76 (3.4%) stddev-sans-first:2.87 07:36:09 INFO - PROCESS | 28767 | Values: 79.0 79.0 81.0 79.0 80.0 81.0 79.0 88.0 80.0 79.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:134.50 stddev:12.12 (9.0%) stddev-sans-first:12.81 07:36:09 INFO - PROCESS | 28767 | Values: 135.0 133.0 137.0 133.0 131.0 138.0 134.0 133.0 172.0 134.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:180.00 stddev:2.73 (1.5%) stddev-sans-first:2.86 07:36:09 INFO - PROCESS | 28767 | Values: 178.0 181.0 175.0 178.0 181.0 182.0 179.0 183.0 175.0 179.0 07:36:09 INFO - PROCESS | 28767 | 07:36:09 INFO - PROCESS | 28767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:2.57 (3.5%) stddev-sans-first:2.69 07:36:09 INFO - PROCESS | 28767 | Values: 72.0 72.0 73.0 73.0 74.0 73.0 80.0 73.0 71.0 71.0 07:36:09 INFO - PROCESS | 28767 | -------- Summary: end -------- 07:36:09 INFO - PROCESS | 28767 | 07:36:10 INFO - TEST-INFO | 28767: exit 0 07:36:10 INFO - TEST-OK | kraken | took 63584ms 07:36:10 INFO - SUITE-END | took 1182s 07:36:10 INFO - Completed test suite (00:19:42) 07:36:10 INFO - javascript benchmark 07:36:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.7035640901295, 2609.8042646801473, 2642.907498237562, 2650.8542030188332, 2650.867456627168, 4531.456225252974, 4578.954210457894, 4605.654575906804, 4606.700564463312, 4629.282461218512, 4602.516735742749, 4655.208614535529, 4693.037927224919, 4712.434507859061, 4723.787429565669, 4252.107057517925, 4268.850590229343, 4310.956890431103, 4330.718503297291, 4403.273459879132, 4285.314349704048, 4309.37514060461, 4365.80353884076, 4399.208142534342, 4403.801828917706, 4160.646345060673, 4317.287647538153, 4356.8257269709175, 4370.104128653635, 4375.2124617568825, 4186.937195942063, 4193.664506839476, 4236.872893813191, 4266.296061149907, 4327.415798867144, 4208.263553878059, 4216.325387937915, 4227.598378154071, 4262.062346283813, 4267.146570685844, 4362.323839804835, 4499.032707967803, 4505.43682039745, 4513.887152821173, 4541.159885421174, 4960.107180707471, 5012.1980483122525, 5016.698998060128, 5050.39395272566, 5066.620003499752, 4970.676906001135, 4982.90034199314, 4985.252212168168, 4999.150144475448, 5053.797848086072, 4497.347884556721, 4637.466691330473, 4673.322368256618, 4674.041821426667, 4674.32222327764, 5054.140796064605, 5059.494050594984, 5063.822766203165, 5095.414027386824, 5119.923201151985, 4850.466448690641, 4857.635677324215, 4859.052484765508, 4864.6594738368685, 4911.877203069952, 4777.976110119496, 4895.853124406202, 4942.1104201244125, 4972.4033116025585, 4990.600751939909, 4833.299171620095, 4838.225883858566, 4847.151748444008, 4897.657163998486, 4913.778879950411, 4826.32431459596, 4827.155247831615, 4829.710217386968, 4850.80596776125, 4881.585065269421, 3988.142549351903, 4048.7570745755347, 4078.347464405681, 4084.81618327176, 4123.60825721556, 3593.7749083372914, 3600.963990360115, 3644.362236608583, 3645.3985092459448, 3662.066173125836, 4292.420523229386, 4293.74237545742, 4293.742375457483, 4295.226859165317, 4338.544452832407, 4817.470078291385, 4923.606111511071, 4944.035912996931, 4994.750262486861, 4998.800047998112, 4255.3616957456625, 4271.402003719481, 4277.679174061957, 4281.721688090264, 4315.482142142963, 4428.092241090569, 4429.247028005247, 4432.246518091868, 4475.172093162711, 4476.395686582335, 4572.0627271409285, 4691.967767091234, 4741.407324084489, 4761.1429942609275, 4771.427428708438, 4882.4629290777275, 4905.533974272438, 4905.656604037826, 4907.803687852589, 4952.678075925198, 4534.863954081383, 4696.201645720304, 4703.223968045234, 4707.17624415719, 4749.952500474951, 4876.926846097383, 4956.6530342877095, 4960.057589058068, 4963.801447942042, 4969.35398398206, 4953.133201689762, 4960.553550180501, 4961.7519124044375, 4968.801247950186, 5004.299398084198, 4813.3983252093485, 4818.759062046814, 4824.638152138534, 4828.517148285144, 4839.516048395132, 4711.222648263135, 4784.64115191369, 4826.6621336506105, 4861.805527778849, 4873.829415970424, 4735.408073990751, 4736.218523943511, 4738.360321356573, 4744.074905393553, 4775.6418268629295, 4843.491433399583, 4843.878903027312, 4844.0554091953145, 4847.248676455155, 4897.853064408074, 4581.633469322513, 4674.392328997209, 4784.234522476387, 4860.052289803454, 4862.4651288357545], "value": 4543.533846634307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7660370946057, 582.6911736779508, 583.2330485411684, 587.9088741245104, 606.8877257707325, 33557.328853422914, 34594.135146621345, 34619.0, 34632.307353852906, 34649.48025779609, 36591.45112823303, 37199.44200836983, 37404.625953740455, 37430.62569374305, 37502.812485937604, 7156.928430715679, 7591.924080759204, 7814.101378341478, 7827.217278272185, 9419.670311539097, 9581.568829402659, 9731.075547822946, 9742.659006934759, 9747.025297470267, 9750.0, 9686.273529485281, 9742.659006934759, 9751.756206094833, 9758.707238782812, 9774.609015639366, 7410.444216683743, 7688.6155692215725, 7692.153863075057, 7696.307332340116, 9672.468014259213, 9639.228861691048, 10061.849072263922, 10088.848667269996, 10101.343412678227, 10104.292699511037, 34086.31827363439, 34703.479447808306, 34762.82618586916, 34771.478427823604, 34819.303613927834, 3071.1861356740483, 3296.175956010997, 3334.1992726109943, 3725.4225595032813, 3897.6686981606313, 26393.736062639513, 26897.0, 26967.190984270503, 28678.0, 28730.856345718348, 3447.5518182636347, 3485.7734247273847, 3625.782453052825, 3637.418013117915, 3638.181409182939, 231641.0, 232358.8382058096, 232364.0, 232952.0, 233045.0, 34008.65991340105, 54817.0, 54869.45130548644, 55277.447225528034, 55286.447135528935, 33311.50032749462, 33353.0, 33475.0, 33487.497687534706, 33530.66469335275, 12829.358532073358, 13000.049992501012, 13012.479500819862, 13019.739605207842, 13020.869791301966, 9415.952920235355, 10211.132053775364, 10541.525631346607, 10554.0, 10567.788644227072, 7990.081140668781, 8004.279614834692, 8078.35373170145, 8119.147489513634, 8158.551279679675, 3146.0, 3177.2851108500404, 3201.295714942709, 3213.742900567949, 3256.2836176041706, 938.6245501799335, 961.2982522758425, 991.1723710701644, 1017.97455063624, 1026.373911913732, 28365.71634283631, 28755.712442875723, 28957.841686332733, 29103.272418189714, 29356.706432935825, 959.4770849886828, 985.679654112402, 988.5255077562811, 1000.8248556502583, 1064.7125276175543, 14641.48754793577, 15165.165915874511, 15266.770998435033, 15428.845711542965, 15601.297941592655, 342421.0, 369923.0, 382550.0, 383090.0, 384693.0, 48461.27308090381, 49270.75364623154, 49625.50374496209, 49670.50329496731, 49695.0, 1224.706070543081, 1238.0405185980937, 1248.2822377133184, 1250.1623911978813, 1318.6637407461037, 27635.4729054194, 28987.85506072456, 29167.270818229714, 29651.0, 29938.0, 42352.364714529926, 42778.57221427746, 43059.0, 43136.35295470508, 43190.0, 324360.0, 325886.0, 326618.0, 326896.0, 328382.0, 22053.889730551888, 22629.0, 22785.430364241027, 25168.49663006693, 25639.743602564482, 36279.0, 36888.63111368852, 37001.814990924875, 37232.81383593065, 37359.626403735616, 32344.514832278004, 34702.93343922152, 35269.82365088158, 35353.46969795404, 35546.64453355433, 33427.164320892174, 33704.66295337015, 34530.136746581535, 34614.480782788785, 34718.82640586781, 33471.83264083664, 33730.494042589875, 34153.829230853684, 34372.48441273433, 34442.0, 28784.280392990342, 31079.0, 31217.219569510944, 31233.0, 31236.37527249488, 24292.271231863073, 24515.509689806462, 24558.263252102464, 24840.254792355536, 24855.254342369757], "value": 16573.684328512027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.5403111033432, 363.60185596771544, 370.60160327647776, 374.7152164355091, 383.5340061824882, 15765.448209312677, 16630.417935372265, 17813.73279400807, 17863.46409607714, 17867.821321786778, 16313.510594682179, 16360.754588681179, 17398.565035874108, 17398.82601173988, 17425.738613920803, 5022.497750224976, 5150.356205474316, 5175.275461435402, 5177.404598471167, 5179.507946745053, 3684.1894783147663, 3876.8061596920184, 5110.616703747215, 5595.21666966625, 5938.88122237555, 5833.183354330397, 5864.882702345951, 5895.410458954113, 5896.498797602209, 5902.321233058189, 5656.660600363971, 5877.970610146965, 5890.97054514729, 5891.440313170264, 5901.203337549418, 3319.286353434023, 4884.7069175849565, 5134.358205224347, 5135.87160320995, 5138.0, 19239.653224274167, 19259.22963081489, 19277.325293614656, 20620.79379206204, 20641.690374644393, 1843.060039379926, 1907.16084922635, 1937.2832052140657, 2078.4401725384687, 2489.73023757883, 8470.957645211734, 9119.088091190893, 9190.264778817746, 9391.389559678599, 12986.610401687965, 1760.5334586334632, 1789.6845818323523, 1791.7133258678548, 1818.6180902010594, 1852.3331600623765, 62976.37023629751, 65492.67253663749, 66507.0, 66630.33369666242, 67238.32761672369, 9627.90372096284, 9742.512874356396, 9908.851367229354, 9917.068600576073, 10162.085412312927, 12960.222386656831, 13047.347632618332, 13053.673658158432, 13086.672833179056, 13099.2140471572, 6944.618046007518, 6949.583025018515, 7074.089995701132, 7092.361687448154, 7098.609576473344, 6539.2479864815205, 6634.933650663432, 6696.363845434676, 6710.731570737214, 6751.0886030386255, 4104.0970986382945, 4126.42230087788, 4170.249355116108, 4207.8316867325575, 4219.050713589418, 1705.6844483770542, 1773.6364045370926, 1776.6801975644507, 1824.5954276271943, 1845.2526726675717, 832.6419639554929, 853.799357151069, 866.6706651472526, 879.5294517433271, 896.8699538567001, 15892.284847181905, 16423.67152656964, 16577.91711041437, 16795.2442140104, 16922.40771572989, 885.6811547842772, 892.5001998880648, 905.7690288976269, 908.2688435809237, 932.6409332407072, 9204.263658907405, 9324.720258392259, 9535.761605959768, 9558.378705384128, 9591.328606997582, 393378.0, 393676.0, 398847.0, 405523.0, 407468.0, 72962.63518682373, 73068.0, 74158.0, 74634.62682686551, 74831.62584187153, 926.1942110364026, 945.4894357047255, 959.7792507723262, 960.8606752020918, 962.2686758063921, 14709.190994495406, 14775.408983640964, 14868.479603213835, 14944.476943306932, 15259.160746159068, 32083.679163208068, 32431.35137297288, 33174.17064573309, 33490.497642534894, 33634.49548256729, 45722.77138614286, 45804.48075355888, 45845.31232031455, 46007.53992460033, 46344.0, 7765.22347765219, 7893.284543063481, 7898.2891539761695, 7950.761477155464, 8014.479058861389, 8742.519161446182, 10840.753313369063, 11604.825927610924, 11712.590059347882, 11876.408911536364, 10480.68557943263, 10500.697147940242, 10530.104941080093, 10545.630902918361, 10627.256092073481, 10095.0, 10239.7440063999, 10442.060214580724, 10452.895471045193, 10519.737006574896, 10237.283390162616, 10290.073893349634, 10486.423246721199, 10643.860061281786, 10797.974192451704, 7671.884921726067, 7772.45592808498, 7947.602619869099, 7976.042874855055, 8173.79565510867, 9532.90467095348, 10342.896571034495, 10344.948275258575, 10400.843987340348, 10471.3193642413], "value": 8130.282667949726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.9022478201746, 1421.2893553223385, 1455.8908081893858, 1582.9683406331874, 1773.7516747655322, 6455.193100862392, 7156.248593897637, 7346.4122870170395, 7362.705491780336, 7411.814704632387, 7122.8575428491395, 7197.856042879139, 7215.639218039103, 7238.891416628755, 7267.23694012129, 1876.6246750649857, 2121.109134163651, 2151.9569608607817, 2157.1263638226465, 2223.3663405929315, 2165.2854557995825, 2176.2383165891893, 2184.170015394156, 2184.2464349799293, 2184.8798316092607, 2113.123053932624, 2158.9784102158933, 2161.3948094533557, 2161.7513985891665, 2161.8378621603365, 1888.792232854385, 2134.402367337148, 2201.3506015725397, 2202.559488102386, 2205.514786746913, 2088.258668172792, 2102.3482720356737, 2106.568153528523, 2108.6731556608597, 2110.6095372356162, 7296.124465064173, 7296.270372962715, 7328.523645962995, 7368.115826100902, 7370.336669699753, 4208.3687446882905, 4319.114581510814, 4322.654187664979, 4362.629176519999, 4372.519022907478, 2818.873150708223, 2868.3259434033193, 2893.6238289022504, 2897.130860741769, 2931.721486458783, 917.651292508849, 926.8285367207088, 940.3370623710337, 955.2787645327733, 957.7270477913761, 9842.80314393708, 9875.555599998017, 9895.554700038516, 10015.499225038719, 10037.749056273651, 3975.1254723960683, 4047.494063242095, 4146.460960075171, 4189.664826813848, 4191.266528357525, 8530.10433904431, 8552.40133190683, 8555.572221388906, 8563.614637341334, 8575.571221439028, 3888.0, 4474.194644963938, 4478.843240486633, 4498.257787465097, 4505.81976720934, 3988.282109220368, 4071.4707088078953, 4072.3687828386646, 4072.775997320176, 4117.56765539614, 3526.2947410518, 3556.78659280444, 3623.7644553103964, 3632.54593175853, 3669.9816500917323, 1192.952281908714, 1211.618340222827, 1214.7023979125172, 1222.2910711787142, 1225.497546006151, 799.192815256595, 853.8164294676675, 882.7660669922476, 890.283321925843, 902.7111324376268, 5261.789528418821, 5296.9141326028075, 5315.920261196085, 5499.092649712833, 5506.779728810803, 903.5708038681573, 933.0622724162174, 936.8782058332373, 938.474454305591, 941.3034354577563, 3709.239605880788, 3791.2227993261317, 3796.487474191004, 3820.2550502651716, 3850.7111966602056, 8483.278921291636, 8541.701040463555, 8880.822383552293, 8881.866771998426, 8908.331875109392, 8686.6525338987, 8737.868931966026, 8742.431741936754, 8774.649014039494, 8816.162464565856, 6833.214180369222, 6867.141607299088, 6964.860702785916, 6988.126484189476, 6989.091418115714, 5184.300119483822, 5268.157094864803, 5270.920936186037, 5281.049411106038, 5364.544013758874, 8250.834983300181, 8319.625616847377, 8419.789505262417, 8486.236238738544, 8488.957555212184, 8462.0, 8481.151884811716, 8618.65525379003, 8622.78443038929, 8681.522516261666, 5715.399883012224, 6083.939160608337, 6223.782167624111, 6287.779927702509, 6400.231972163184, 7122.145342558926, 7202.71189152449, 7256.1655409628565, 7276.745313913988, 7291.890621640786, 6510.153680021756, 6553.344665533408, 6588.8023359299295, 6601.834954125993, 6777.051212830109, 6588.8023359299295, 6624.701888414937, 6657.1345725055435, 6692.230393504809, 6698.933010670026, 6347.587406818542, 6388.275165705327, 6394.296627370893, 6395.744170233139, 6400.103985441949, 4295.334223195409, 4441.37820705108, 4474.776261186993, 4541.250693635513, 4636.953630463652, 4631.166390049823, 4657.6506761992305, 4695.6243500519195, 4734.905301894012, 4762.690425122356], "value": 4041.449930844018, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.56259173830983, 302.40275455974444, 304.885667874547, 313.59859379993617, 315.2198309184768, 4941.184704523749, 5099.235114732792, 5132.101882170619, 5202.921956170656, 5213.08770965081, 4875.146849301375, 5049.39407271127, 5101.311322971398, 5132.769025393857, 5142.922856157152, 3994.600539945997, 3999.740016898907, 4005.8597949071786, 4009.9599004010024, 4011.8595849145286, 3775.8112094395306, 3816.255830113129, 3958.7228893977435, 3996.880873355465, 4019.5980401959714, 3941.60583941605, 3952.347862602667, 3982.1040265940223, 3988.421678856564, 4007.7394969327047, 3985.561588225293, 4001.8199181036775, 4004.3793212051887, 4005.2790497710403, 4015.959840401588, 3475.739319551044, 3539.0975301298004, 3539.876104336336, 3548.2436194083834, 3558.839852206657, 4912.459629440758, 4918.631102667278, 4919.950800491985, 4939.728314942677, 4942.159832828428, 4582.221022426163, 4586.678932474728, 4588.24293991491, 4609.608183304423, 4612.423447069116, 5192.92210616841, 5371.328583927009, 5385.542228910547, 5394.271773310592, 5402.459754024605, 3847.8653247136217, 3863.536375634914, 3865.91754308794, 3868.1103346230243, 3868.18768058708, 5573.777048918038, 5617.606767526275, 5630.5495560355075, 5639.605227634067, 5665.263515742969, 3955.367141257385, 3956.287868183697, 3957.248122856648, 3960.1881614269005, 3963.623455771697, 3669.1744357519347, 3870.1679138985255, 3880.835749275206, 3891.2606604745006, 4021.6782657387926, 4427.380166776654, 4453.064856380196, 4461.977690111528, 4468.352088947085, 4484.192845287815, 5356.330458692663, 5362.034833729966, 5369.5167434931045, 5379.327584051994, 5384.246205531229, 1274.20362273579, 1282.602393258093, 1298.7597294500358, 1307.8561358250586, 1314.572763851752, 900.203320061737, 903.6972614174325, 916.2532535983153, 916.4684482999844, 925.1488630459993, 4736.786844592001, 4742.762861856893, 4745.454272758677, 4746.430428348551, 4748.216544270226, 5444.156155795858, 5455.454454554592, 5459.727013649302, 5472.863178420492, 5478.150886612581, 4781.808727650855, 4781.808727650925, 4782.0, 4787.210110331756, 4790.7365094920115, 2933.530635098374, 2938.5445255985355, 2953.3059730963205, 2960.304328482805, 2962.5408061750463, 4975.776090075955, 5084.3644544431945, 5164.948350516522, 5197.870053248624, 5243.2659427680155, 5588.385277619459, 5723.910772567982, 5736.225609542658, 5743.396943320891, 5754.88490230193, 5204.869878253074, 5292.761825717852, 5302.469753024821, 5308.336457942757, 5318.867028324323, 5550.250716153268, 5588.804391846266, 5591.440855914376, 5596.608237423341, 5614.410486898817, 5447.673139611636, 5449.509544141047, 5461.972690136524, 5485.122380419273, 5485.753141108739, 5072.315237443046, 5332.9466705334, 5341.839744807662, 5375.489328513785, 5383.5962302826665, 3872.6708229800784, 3879.9224015518967, 3898.577019387846, 3906.3554513504955, 3911.1786524830104, 5669.234653321913, 5671.6029877909805, 5671.773129074791, 5680.9147862781265, 5690.516306113861, 5378.220158077135, 5478.150886612581, 5482.150266708666, 5489.560835133259, 5500.42245564226, 5465.726713664221, 5468.0, 5475.972620136874, 5477.75350109254, 5478.287822583198, 5367.892642147213, 5377.892442151213, 5383.461653834585, 5383.623146379716, 5391.7304134793885, 5280.86797830042, 5454.181872718965, 5505.366882808528, 5518.834434966958, 5520.365158006881, 5350.759215835219, 5360.249565060816, 5371.543418809445, 5371.62398632092, 5373.2746079278795], "value": 4053.603000066545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.8003438985498, 726.2156870579774, 755.5693254844738, 775.7129861951072, 791.540906274361, 11513.827292590608, 11744.765104697912, 11879.70300742482, 11884.049276057916, 11900.880991190097, 12173.756524869497, 12796.552120675778, 12804.615861524146, 12808.295543745113, 12810.615681529545, 553.2475832867298, 776.6233376812241, 799.5442597719302, 805.5810978291285, 805.8025783682976, 798.2695833312512, 798.8002999250187, 798.9201079892023, 799.9080105787822, 801.9478733882308, 840.932725381968, 842.6545116502235, 843.3590471241839, 843.7510934274374, 844.1727107434717, 648.2124219073825, 813.4834380168577, 827.2843989948711, 828.6229765456764, 836.0719601242616, 608.996955015222, 610.5787006965224, 610.8289678889873, 611.966341851198, 615.6829232945037, 12126.575569855013, 12133.272003679807, 12147.392630368446, 12188.695282617917, 12192.695182620417, 11845.407729613486, 12380.257184568954, 12646.051546134076, 12699.0, 12783.5525756599, 10837.620683276127, 11153.163512736577, 11401.714957126056, 11420.42897855104, 11551.133664975161, 3240.4653232216656, 3304.93390132196, 3315.6187038490643, 3389.9661003390142, 3403.5745531808525, 44519.554804452186, 45580.999999999665, 46144.3078353825, 46647.30029049567, 46891.0, 9519.666811661558, 9641.469719165514, 9662.661806836726, 9751.65869194589, 9853.852192216978, 17060.91469542669, 17063.061531615633, 17070.23183956725, 17079.65840683204, 17107.572310692332, 6786.762463313859, 6796.626185559743, 6899.965500172467, 7044.964775176194, 7099.609521476368, 3772.245550889833, 3828.789416582059, 3856.4986551748652, 3868.7678739275734, 3951.0122469382654, 2797.4405118976288, 2843.616111824877, 2856.0860524631917, 2858.3568697043415, 2859.7998140130408, 413.2643893868918, 471.3660127129006, 485.0928763212744, 487.8365747474636, 523.602062432554, 575.2234483447396, 632.7627139822566, 643.4369926314475, 659.0838734159522, 661.4080398043724, 7325.4139668826365, 7471.178170401252, 7647.541147531166, 7690.500117492345, 8082.313003394777, 537.247853005795, 580.5848818095083, 583.6789765628972, 663.5653646861314, 666.2926424808711, 3817.3128836809087, 3840.231953609289, 3881.437191607258, 3935.626115519021, 4038.495188101487, 48389.27416088691, 48789.512104879206, 49417.50582494201, 50029.249561255885, 50180.498195018314, 34214.82892585521, 37571.06072348213, 38811.41782873259, 40695.59304406977, 43569.78215108904, 32652.0, 33771.29829613625, 34425.82787086099, 39052.6094739049, 39702.60297397047, 7484.438667100098, 8231.794205144919, 8247.876281855657, 8301.709440169565, 8313.83372332562, 27898.30254243579, 28551.571726423706, 28757.85621071881, 28915.7108428913, 29267.853660731562, 35851.64148358483, 36088.45867312045, 36194.92343150757, 36313.0, 36791.8160409207, 11237.55049797999, 11304.217469518224, 11443.14176436754, 11468.139889508153, 11489.080873530265, 11995.700107497383, 12267.938660306998, 12347.75304493923, 12385.876141238832, 12386.132970691964, 10721.892781072089, 10835.783284334428, 10848.566057357617, 10937.835932460861, 11263.66209013731, 11374.0, 11655.708607284885, 11998.340091294713, 12098.395080245777, 12132.029437645144, 11386.146039046938, 11576.421178941187, 12076.698082548006, 12131.45408456604, 12138.02895768354, 9079.793790766329, 9192.35653504275, 9383.061693830563, 9388.202002829836, 9565.438171146357, 9285.48929808867, 10003.899961000297, 10010.199184065403, 10053.19574434058, 10057.0], "value": 5901.26520258935, "unit": "score"}], "name": "dromaeo_css", "value": 6242.82749075591, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 109.0, 112.0, 115.0, 113.0, 101.0, 112.0, 113.0, 120.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 143.0, 173.0, 198.0, 134.0, 160.0, 163.0, 139.0, 188.0, 136.0], "value": 159.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 160.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 110.0, 108.0, 75.0, 76.0, 76.0, 127.0, 101.0, 73.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 142.0, 93.0, 93.0, 95.0, 143.0, 94.0, 94.0, 147.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 86.0, 64.0, 63.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 81.0, 79.0, 80.0, 81.0, 79.0, 88.0, 80.0, 79.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 137.0, 133.0, 131.0, 138.0, 134.0, 133.0, 172.0, 134.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 181.0, 175.0, 178.0, 181.0, 182.0, 179.0, 183.0, 175.0, 179.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 73.0, 74.0, 73.0, 80.0, 73.0, 71.0, 71.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1590.8, "alertThreshold": 2.0}]} 07:36:11 INFO - Return code: 0 07:36:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:36:11 ERROR - # TBPL SUCCESS # 07:36:11 INFO - Running post-action listener: _resource_record_post_action 07:36:11 INFO - Running post-run listener: _resource_record_post_run 07:36:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 2457600; Write bytes: 519303168; Read time: 1080; Write time: 523728 07:36:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 201715712; Read time: 0; Write time: 255832 07:36:12 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 2457600; Write bytes: 285016064; Read time: 1080; Write time: 260200 07:36:12 INFO - Running post-run listener: _upload_blobber_files 07:36:12 INFO - Blob upload gear active. 07:36:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:12 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 07:36:12 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'] 07:36:12 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 07:36:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:13 INFO - (blobuploader) - INFO - Done attempting. 07:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:15 INFO - (blobuploader) - INFO - Done attempting. 07:36:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:15 INFO - Return code: 0 07:36:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bd42d675d33e2d9bb96ea4f8e8d035d44ed5da46bf836fb0b9904f6a96f5e2de2b4d3796dd220f49a43e666ac4336acb09c46ca756786e8b907d0489c2f521c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa146d001e46a5b30ac407b99d3f1f0f877a3ec07b012df89e673dd33b85d5c166177032064575e984042fb3da22fd3316bad6cba62d88baf8e036c602b0e55"} 07:36:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:15 INFO - Contents: 07:36:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bd42d675d33e2d9bb96ea4f8e8d035d44ed5da46bf836fb0b9904f6a96f5e2de2b4d3796dd220f49a43e666ac4336acb09c46ca756786e8b907d0489c2f521c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa146d001e46a5b30ac407b99d3f1f0f877a3ec07b012df89e673dd33b85d5c166177032064575e984042fb3da22fd3316bad6cba62d88baf8e036c602b0e55"} 07:36:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:15 INFO - Copying logs to upload dir... 07:36:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.792657 ========= master_lag: 44.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-04-21 07:36:59.305855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 07:36:59.309423) ========= 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=db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775 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/3bd42d675d33e2d9bb96ea4f8e8d035d44ed5da46bf836fb0b9904f6a96f5e2de2b4d3796dd220f49a43e666ac4336acb09c46ca756786e8b907d0489c2f521c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa146d001e46a5b30ac407b99d3f1f0f877a3ec07b012df89e673dd33b85d5c166177032064575e984042fb3da22fd3316bad6cba62d88baf8e036c602b0e55"} build_url:https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/Tn9_QgCySe-xpFfPC1GWZg/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/3bd42d675d33e2d9bb96ea4f8e8d035d44ed5da46bf836fb0b9904f6a96f5e2de2b4d3796dd220f49a43e666ac4336acb09c46ca756786e8b907d0489c2f521c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfa146d001e46a5b30ac407b99d3f1f0f877a3ec07b012df89e673dd33b85d5c166177032064575e984042fb3da22fd3316bad6cba62d88baf8e036c602b0e55"}' ========= master_lag: 0.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 07:36:59.573787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 20 secs) (at 2016-04-21 07:36:59.574139) ========= 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=db0483c52d987ecb441a263b000001ad-1461244037.356877-1958006775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 20.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 20 secs) (at 2016-04-21 07:37:19.968857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 07:37:19.969216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 07:37:20.132118) ========= ========= Total master_lag: 64.74 =========