builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1469129979.18 results: success (0) buildid: 20160721073720 builduid: 66c3ba6aeda144fc8ac69205b6970116 revision: 6688064e8ad629276830b941df87681a21b67cdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.185080) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.185539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.185816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.201128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.201474) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 12:39:39-- 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% 33.3M=0s 2016-07-21 12:39:39 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.300704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.301017) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.350190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:39.350554) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6688064e8ad629276830b941df87681a21b67cdc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6688064e8ad629276830b941df87681a21b67cdc --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=6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 12:39:39,775 truncating revision to first 12 chars 2016-07-21 12:39:39,775 Setting DEBUG logging. 2016-07-21 12:39:39,775 attempt 1/10 2016-07-21 12:39:39,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6688064e8ad6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 12:39:40,088 unpacking tar archive at: mozilla-beta-6688064e8ad6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:40.007252) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:40.010604) ========= script_repo_revision: 6688064e8ad629276830b941df87681a21b67cdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:40.010999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:40.011268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 12:39:40.022155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-21 12:39:40.022518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:40 INFO - MultiFileLogger online at 20160721 12:39:40 in /builds/slave/test 12:39:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:39:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:40 INFO - {'append_to_log': False, 12:39:40 INFO - 'base_work_dir': '/builds/slave/test', 12:39:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:39:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:40 INFO - 'branch': 'Mozilla-Beta', 12:39:40 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:40 INFO - 'config_files': ('talos/linux_config.py',), 12:39:40 INFO - 'default_actions': ('clobber', 12:39:40 INFO - 'read-buildbot-config', 12:39:40 INFO - 'download-and-extract', 12:39:40 INFO - 'populate-webroot', 12:39:40 INFO - 'create-virtualenv', 12:39:40 INFO - 'install', 12:39:40 INFO - 'run-tests'), 12:39:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:40 INFO - 'download_minidump_stackwalk': True, 12:39:40 INFO - 'download_symbols': 'ondemand', 12:39:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:40 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:40 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:40 INFO - 'installer_path': 'installer.exe', 12:39:40 INFO - 'log_level': 'info', 12:39:40 INFO - 'log_name': 'talos', 12:39:40 INFO - 'log_to_console': True, 12:39:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:40 INFO - 'opt_config_files': (), 12:39:40 INFO - 'pip_index': False, 12:39:40 INFO - 'sps_profile': False, 12:39:40 INFO - 'sps_profile_interval': 0, 12:39:40 INFO - 'suite': 'dromaeojs', 12:39:40 INFO - 'system_bits': '32', 12:39:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:40 INFO - 'title': 'talos-linux64-ix-023', 12:39:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:40 INFO - 'use_talos_json': True, 12:39:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:40 INFO - 'work_dir': 'build'} 12:39:40 INFO - ##### 12:39:40 INFO - ##### Running clobber step. 12:39:40 INFO - ##### 12:39:40 INFO - Running pre-action listener: _resource_record_pre_action 12:39:40 INFO - Running main action method: clobber 12:39:40 INFO - rmtree: /builds/slave/test/build 12:39:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:41 INFO - Running post-action listener: _resource_record_post_action 12:39:41 INFO - ##### 12:39:41 INFO - ##### Running read-buildbot-config step. 12:39:41 INFO - ##### 12:39:41 INFO - Running pre-action listener: _resource_record_pre_action 12:39:41 INFO - Running main action method: read_buildbot_config 12:39:41 INFO - Using buildbot properties: 12:39:41 INFO - { 12:39:41 INFO - "project": "", 12:39:41 INFO - "product": "firefox", 12:39:41 INFO - "script_repo_revision": "production", 12:39:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:39:41 INFO - "repository": "", 12:39:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:39:41 INFO - "buildid": "20160721073720", 12:39:41 INFO - "pgo_build": "True", 12:39:41 INFO - "basedir": "/builds/slave/test", 12:39:41 INFO - "buildnumber": 310, 12:39:41 INFO - "slavename": "talos-linux64-ix-023", 12:39:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:39:41 INFO - "platform": "ubuntu64_hw", 12:39:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:39:41 INFO - "branch": "mozilla-beta", 12:39:41 INFO - "repo_path": "releases/mozilla-beta", 12:39:41 INFO - "revision": "6688064e8ad629276830b941df87681a21b67cdc", 12:39:41 INFO - "stage_platform": "linux64-pgo", 12:39:41 INFO - "builduid": "66c3ba6aeda144fc8ac69205b6970116", 12:39:41 INFO - "slavebuilddir": "test" 12:39:41 INFO - } 12:39:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 12:39:41 INFO - Running post-action listener: _resource_record_post_action 12:39:41 INFO - ##### 12:39:41 INFO - ##### Running download-and-extract step. 12:39:41 INFO - ##### 12:39:41 INFO - Running pre-action listener: _resource_record_pre_action 12:39:41 INFO - Running main action method: download_and_extract 12:39:41 INFO - mkdir: /builds/slave/test/build/tests 12:39:41 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')]} 12:39:41 INFO - https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:39:41 INFO - Downloaded 1327 bytes. 12:39:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:39:41 INFO - Using the following test package requirements: 12:39:41 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:39:41 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:41 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 12:39:41 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'jsshell-linux-x86_64.zip'], 12:39:41 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:41 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:39:41 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 12:39:41 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 12:39:41 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:41 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:39:41 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:41 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:41 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')]} 12:39:41 INFO - https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:42 INFO - Downloaded 24200531 bytes. 12:39:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:39:43 INFO - Return code: 0 12:39:43 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:39: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')]} 12:39:43 INFO - https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:45 INFO - Downloaded 24200531 bytes. 12:39:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:39:46 INFO - Return code: 0 12:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:46 INFO - https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:39:47 INFO - Downloaded 10840145 bytes. 12:39:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:39:47 INFO - Return code: 0 12:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:47 INFO - https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:39:48 INFO - Downloaded 56022946 bytes. 12:39:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:39:48 INFO - mkdir: /builds/slave/test/properties 12:39:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:39:48 INFO - Writing to file /builds/slave/test/properties/build_url 12:39:48 INFO - Contents: 12:39:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:39:49 INFO - Running post-action listener: _resource_record_post_action 12:39:49 INFO - Running post-action listener: set_extra_try_arguments 12:39:49 INFO - ##### 12:39:49 INFO - ##### Running populate-webroot step. 12:39:49 INFO - ##### 12:39:49 INFO - Running pre-action listener: _resource_record_pre_action 12:39:49 INFO - Running main action method: populate_webroot 12:39:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:49 INFO - '--tppagecycles', 12:39:49 INFO - '7'], 12:39:49 INFO - 'tests': ['tsvgm']}}, 12:39:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:39:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:39:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:39:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['damp', 'tps']}, 12:39:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'tests': ['damp', 'tps']}, 12:39:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['dromaeo_dom']}, 12:39:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['a11yr', 12:39:49 INFO - 'ts_paint', 12:39:49 INFO - 'tpaint', 12:39:49 INFO - 'sessionrestore', 12:39:49 INFO - 'sessionrestore_no_auto_restore', 12:39:49 INFO - 'tabpaint']}, 12:39:49 INFO - 'other-e10s': {'tests': ['a11yr', 12:39:49 INFO - 'ts_paint', 12:39:49 INFO - 'tpaint', 12:39:49 INFO - 'sessionrestore', 12:39:49 INFO - 'sessionrestore_no_auto_restore', 12:39:49 INFO - 'tabpaint']}, 12:39:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:39:49 INFO - 'ts_paint', 12:39:49 INFO - 'tpaint', 12:39:49 INFO - 'sessionrestore', 12:39:49 INFO - 'sessionrestore_no_auto_restore', 12:39:49 INFO - 'tabpaint']}, 12:39:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:39:49 INFO - 'ts_paint', 12:39:49 INFO - 'tpaint', 12:39:49 INFO - 'sessionrestore', 12:39:49 INFO - 'sessionrestore_no_auto_restore', 12:39:49 INFO - 'tabpaint']}, 12:39:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['a11yr', 12:39:49 INFO - 'ts_paint', 12:39:49 INFO - 'tpaint', 12:39:49 INFO - 'sessionrestore', 12:39:49 INFO - 'sessionrestore_no_auto_restore', 12:39:49 INFO - 'tabpaint']}, 12:39:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['a11yr', 12:39:49 INFO - 'ts_paint', 12:39:49 INFO - 'tpaint', 12:39:49 INFO - 'sessionrestore', 12:39:49 INFO - 'sessionrestore_no_auto_restore', 12:39:49 INFO - 'tabpaint']}, 12:39:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['tsvgx', 12:39:49 INFO - 'tsvgr_opacity', 12:39:49 INFO - 'tart', 12:39:49 INFO - 'tscrollx', 12:39:49 INFO - 'cart']}, 12:39:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:39:49 INFO - 'tsvgr_opacity', 12:39:49 INFO - 'tart', 12:39:49 INFO - 'tscrollx', 12:39:49 INFO - 'cart']}, 12:39:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'talos_options': ['--disable-e10s'], 12:39:49 INFO - 'tests': ['tp5o']}, 12:39:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'tests': ['tp5o']}, 12:39:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'talos_options': ['--disable-e10s', 12:39:49 INFO - '--xperf_path', 12:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:49 INFO - 'tests': ['tp5n']}, 12:39:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:49 INFO - 'talos_options': ['--xperf_path', 12:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:49 INFO - 'tests': ['tp5n']}}, 12:39:49 INFO - 'talos.zip': {'path': '', 12:39:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:49 INFO - Running post-action listener: _resource_record_post_action 12:39:49 INFO - ##### 12:39:49 INFO - ##### Running create-virtualenv step. 12:39:49 INFO - ##### 12:39:49 INFO - Running pre-action listener: _resource_record_pre_action 12:39:49 INFO - Running main action method: create_virtualenv 12:39:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:39:49 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 12:39:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:39:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:49 INFO - Using real prefix '/usr' 12:39:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:39:50 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:52 INFO - Installing pip.................done. 12:39:52 INFO - Return code: 0 12:39:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39:52 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')]} 12:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:52 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')]} 12:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:52 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:39:52 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 12:39:52 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 12:39:52 INFO - Using env: {'DISPLAY': ':0', 12:39:52 INFO - 'HOME': '/home/cltbld', 12:39:52 INFO - 'LANG': 'en_US.UTF-8', 12:39:52 INFO - 'LANGUAGE': 'en_US:en', 12:39:52 INFO - 'LOGNAME': 'cltbld', 12:39:52 INFO - 'MAIL': '/var/mail/cltbld', 12:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:52 INFO - 'MOZ_NO_REMOTE': '1', 12:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:52 INFO - 'NO_EM_RESTART': '1', 12:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:52 INFO - 'PWD': '/builds/slave/test', 12:39:52 INFO - 'SHELL': '/bin/bash', 12:39:52 INFO - 'SHLVL': '1', 12:39:52 INFO - 'TERM': 'linux', 12:39:52 INFO - 'TMOUT': '86400', 12:39:52 INFO - 'USER': 'cltbld', 12:39:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:52 INFO - '_': '/tools/buildbot/bin/python'} 12:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:52 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 12:39:52 INFO - Cleaning up... 12:39:52 INFO - Return code: 0 12:39:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:39:52 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')]} 12:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:52 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')]} 12:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:52 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:39:52 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 12:39:52 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 12:39:52 INFO - Using env: {'DISPLAY': ':0', 12:39:52 INFO - 'HOME': '/home/cltbld', 12:39:52 INFO - 'LANG': 'en_US.UTF-8', 12:39:52 INFO - 'LANGUAGE': 'en_US:en', 12:39:52 INFO - 'LOGNAME': 'cltbld', 12:39:52 INFO - 'MAIL': '/var/mail/cltbld', 12:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:52 INFO - 'MOZ_NO_REMOTE': '1', 12:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:52 INFO - 'NO_EM_RESTART': '1', 12:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:52 INFO - 'PWD': '/builds/slave/test', 12:39:52 INFO - 'SHELL': '/bin/bash', 12:39:52 INFO - 'SHLVL': '1', 12:39:52 INFO - 'TERM': 'linux', 12:39:52 INFO - 'TMOUT': '86400', 12:39:52 INFO - 'USER': 'cltbld', 12:39:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:52 INFO - '_': '/tools/buildbot/bin/python'} 12:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:52 INFO - Downloading/unpacking psutil>=0.7.1 12:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:54 INFO - Installing collected packages: psutil 12:39:54 INFO - Running setup.py install for psutil 12:39:54 INFO - building 'psutil._psutil_linux' extension 12:39:54 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 12:39:55 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 12:39:55 INFO - building 'psutil._psutil_posix' extension 12:39:55 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 12:39:55 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 12:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:55 INFO - Successfully installed psutil 12:39:55 INFO - Cleaning up... 12:39:55 INFO - Return code: 0 12:39:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:39:55 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')]} 12:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:55 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')]} 12:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:55 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:39:55 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 12:39:55 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 12:39:55 INFO - Using env: {'DISPLAY': ':0', 12:39:55 INFO - 'HOME': '/home/cltbld', 12:39:55 INFO - 'LANG': 'en_US.UTF-8', 12:39:55 INFO - 'LANGUAGE': 'en_US:en', 12:39:55 INFO - 'LOGNAME': 'cltbld', 12:39:55 INFO - 'MAIL': '/var/mail/cltbld', 12:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:55 INFO - 'MOZ_NO_REMOTE': '1', 12:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:55 INFO - 'NO_EM_RESTART': '1', 12:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:55 INFO - 'PWD': '/builds/slave/test', 12:39:55 INFO - 'SHELL': '/bin/bash', 12:39:55 INFO - 'SHLVL': '1', 12:39:55 INFO - 'TERM': 'linux', 12:39:55 INFO - 'TMOUT': '86400', 12:39:55 INFO - 'USER': 'cltbld', 12:39:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:55 INFO - '_': '/tools/buildbot/bin/python'} 12:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:39:57 INFO - Installing collected packages: mozsystemmonitor 12:39:57 INFO - Running setup.py install for mozsystemmonitor 12:39:57 INFO - Successfully installed mozsystemmonitor 12:39:57 INFO - Cleaning up... 12:39:57 INFO - Return code: 0 12:39:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:39:57 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')]} 12:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:57 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')]} 12:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:57 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:39:57 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 12:39:57 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 12:39:57 INFO - Using env: {'DISPLAY': ':0', 12:39:57 INFO - 'HOME': '/home/cltbld', 12:39:57 INFO - 'LANG': 'en_US.UTF-8', 12:39:57 INFO - 'LANGUAGE': 'en_US:en', 12:39:57 INFO - 'LOGNAME': 'cltbld', 12:39:57 INFO - 'MAIL': '/var/mail/cltbld', 12:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:57 INFO - 'MOZ_NO_REMOTE': '1', 12:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:57 INFO - 'NO_EM_RESTART': '1', 12:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:57 INFO - 'PWD': '/builds/slave/test', 12:39:57 INFO - 'SHELL': '/bin/bash', 12:39:57 INFO - 'SHLVL': '1', 12:39:57 INFO - 'TERM': 'linux', 12:39:57 INFO - 'TMOUT': '86400', 12:39:57 INFO - 'USER': 'cltbld', 12:39:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:57 INFO - '_': '/tools/buildbot/bin/python'} 12:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:57 INFO - Downloading/unpacking blobuploader==1.2.4 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:59 INFO - Downloading blobuploader-1.2.4.tar.gz 12:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:39:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:00 INFO - Downloading docopt-0.6.1.tar.gz 12:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:00 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:00 INFO - Running setup.py install for blobuploader 12:40:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:00 INFO - Running setup.py install for requests 12:40:00 INFO - Running setup.py install for docopt 12:40:01 INFO - Successfully installed blobuploader requests docopt 12:40:01 INFO - Cleaning up... 12:40:01 INFO - Return code: 0 12:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:01 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:40:01 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 12:40:01 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 12:40:01 INFO - Using env: {'DISPLAY': ':0', 12:40:01 INFO - 'HOME': '/home/cltbld', 12:40:01 INFO - 'LANG': 'en_US.UTF-8', 12:40:01 INFO - 'LANGUAGE': 'en_US:en', 12:40:01 INFO - 'LOGNAME': 'cltbld', 12:40:01 INFO - 'MAIL': '/var/mail/cltbld', 12:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:01 INFO - 'MOZ_NO_REMOTE': '1', 12:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:01 INFO - 'NO_EM_RESTART': '1', 12:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:01 INFO - 'PWD': '/builds/slave/test', 12:40:01 INFO - 'SHELL': '/bin/bash', 12:40:01 INFO - 'SHLVL': '1', 12:40:01 INFO - 'TERM': 'linux', 12:40:01 INFO - 'TMOUT': '86400', 12:40:01 INFO - 'USER': 'cltbld', 12:40:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:01 INFO - '_': '/tools/buildbot/bin/python'} 12:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:01 INFO - Running setup.py (path:/tmp/pip-6Lx9W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:01 INFO - Running setup.py (path:/tmp/pip-lyORbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:01 INFO - Running setup.py (path:/tmp/pip-bMmnOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:01 INFO - Running setup.py (path:/tmp/pip-Kh7u3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:01 INFO - Running setup.py (path:/tmp/pip-1LEnxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:01 INFO - Running setup.py (path:/tmp/pip-_pEBZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:01 INFO - Running setup.py (path:/tmp/pip-ZmdLRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:01 INFO - Running setup.py (path:/tmp/pip-JdFOaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:01 INFO - Running setup.py (path:/tmp/pip-i4PZga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:01 INFO - Running setup.py (path:/tmp/pip-Vfh6_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:02 INFO - Running setup.py (path:/tmp/pip-vi_Q5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:02 INFO - Running setup.py (path:/tmp/pip-6Hozx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:02 INFO - Running setup.py (path:/tmp/pip-oymEEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:02 INFO - Running setup.py (path:/tmp/pip-XJD37u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:02 INFO - Running setup.py (path:/tmp/pip-XNqUia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:02 INFO - Running setup.py (path:/tmp/pip-XDB8aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:02 INFO - Running setup.py (path:/tmp/pip-4ZWQV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:40:02 INFO - Running setup.py install for manifestparser 12:40:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:40:02 INFO - Running setup.py install for mozcrash 12:40:02 INFO - Running setup.py install for mozdebug 12:40:02 INFO - Running setup.py install for mozdevice 12:40:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:40:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:40:02 INFO - Running setup.py install for mozfile 12:40:03 INFO - Running setup.py install for mozhttpd 12:40:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Running setup.py install for mozinfo 12:40:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Running setup.py install for mozInstall 12:40:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Running setup.py install for mozleak 12:40:03 INFO - Running setup.py install for mozlog 12:40:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Running setup.py install for moznetwork 12:40:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Running setup.py install for mozprocess 12:40:03 INFO - Running setup.py install for mozprofile 12:40:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Running setup.py install for mozrunner 12:40:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:40:03 INFO - Running setup.py install for mozscreenshot 12:40:04 INFO - Running setup.py install for moztest 12:40:04 INFO - Running setup.py install for mozversion 12:40:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:40:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:40:04 INFO - Cleaning up... 12:40:04 INFO - Return code: 0 12:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:04 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:40:04 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 12:40:04 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 12:40:04 INFO - Using env: {'DISPLAY': ':0', 12:40:04 INFO - 'HOME': '/home/cltbld', 12:40:04 INFO - 'LANG': 'en_US.UTF-8', 12:40:04 INFO - 'LANGUAGE': 'en_US:en', 12:40:04 INFO - 'LOGNAME': 'cltbld', 12:40:04 INFO - 'MAIL': '/var/mail/cltbld', 12:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:04 INFO - 'MOZ_NO_REMOTE': '1', 12:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:04 INFO - 'NO_EM_RESTART': '1', 12:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:04 INFO - 'PWD': '/builds/slave/test', 12:40:04 INFO - 'SHELL': '/bin/bash', 12:40:04 INFO - 'SHLVL': '1', 12:40:04 INFO - 'TERM': 'linux', 12:40:04 INFO - 'TMOUT': '86400', 12:40:04 INFO - 'USER': 'cltbld', 12:40:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:04 INFO - '_': '/tools/buildbot/bin/python'} 12:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:04 INFO - Running setup.py (path:/tmp/pip-Sx5XTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:04 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)) 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:04 INFO - Running setup.py (path:/tmp/pip-LpsRh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:04 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)) 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:04 INFO - Running setup.py (path:/tmp/pip-ZT9IqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:04 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)) 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:04 INFO - Running setup.py (path:/tmp/pip-2I0gd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:04 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)) 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:04 INFO - Running setup.py (path:/tmp/pip-peh4aN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:04 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)) 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:04 INFO - Running setup.py (path:/tmp/pip-pHZfUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:04 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)) 12:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:04 INFO - Running setup.py (path:/tmp/pip-v9L_ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:05 INFO - Running setup.py (path:/tmp/pip-62YWRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:05 INFO - Running setup.py (path:/tmp/pip-jy02e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:05 INFO - Running setup.py (path:/tmp/pip-_TIPgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:05 INFO - Running setup.py (path:/tmp/pip-U7qFZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:05 INFO - Running setup.py (path:/tmp/pip-ZfekPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:05 INFO - Running setup.py (path:/tmp/pip-NY7KdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:05 INFO - Running setup.py (path:/tmp/pip-lATV7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:05 INFO - Running setup.py (path:/tmp/pip-3b_c2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:05 INFO - Running setup.py (path:/tmp/pip-EFyhP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:05 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)) 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:05 INFO - Running setup.py (path:/tmp/pip-MHif__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:05 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)) 12:40:05 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)) 12:40:05 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)) 12:40:05 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)) 12:40:05 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)) 12:40:05 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)) 12:40:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40:07 INFO - Downloading blessings-1.6.tar.gz 12:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:40:08 INFO - Installing collected packages: blessings 12:40:08 INFO - Running setup.py install for blessings 12:40:08 INFO - Successfully installed blessings 12:40:08 INFO - Cleaning up... 12:40:08 INFO - Return code: 0 12:40:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:08 INFO - Reading from file tmpfile_stdout 12:40:08 INFO - Current package versions: 12:40:08 INFO - argparse == 1.2.1 12:40:08 INFO - blessings == 1.6 12:40:08 INFO - blobuploader == 1.2.4 12:40:08 INFO - docopt == 0.6.1 12:40:08 INFO - manifestparser == 1.1 12:40:08 INFO - mozInstall == 1.12 12:40:08 INFO - mozcrash == 0.17 12:40:08 INFO - mozdebug == 0.1 12:40:08 INFO - mozdevice == 0.48 12:40:08 INFO - mozfile == 1.2 12:40:08 INFO - mozhttpd == 0.7 12:40:08 INFO - mozinfo == 0.9 12:40:08 INFO - mozleak == 0.1 12:40:08 INFO - mozlog == 3.1 12:40:08 INFO - moznetwork == 0.27 12:40:08 INFO - mozprocess == 0.22 12:40:08 INFO - mozprofile == 0.28 12:40:08 INFO - mozrunner == 6.11 12:40:08 INFO - mozscreenshot == 0.1 12:40:08 INFO - mozsystemmonitor == 0.0 12:40:08 INFO - moztest == 0.7 12:40:08 INFO - mozversion == 1.4 12:40:08 INFO - psutil == 3.1.1 12:40:08 INFO - requests == 1.2.3 12:40:08 INFO - wsgiref == 0.1.2 12:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:08 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:40:08 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 12:40:08 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 12:40:08 INFO - Using env: {'DISPLAY': ':0', 12:40:08 INFO - 'HOME': '/home/cltbld', 12:40:08 INFO - 'LANG': 'en_US.UTF-8', 12:40:08 INFO - 'LANGUAGE': 'en_US:en', 12:40:08 INFO - 'LOGNAME': 'cltbld', 12:40:08 INFO - 'MAIL': '/var/mail/cltbld', 12:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:08 INFO - 'MOZ_NO_REMOTE': '1', 12:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:08 INFO - 'NO_EM_RESTART': '1', 12:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:08 INFO - 'PWD': '/builds/slave/test', 12:40:08 INFO - 'SHELL': '/bin/bash', 12:40:08 INFO - 'SHLVL': '1', 12:40:08 INFO - 'TERM': 'linux', 12:40:08 INFO - 'TMOUT': '86400', 12:40:08 INFO - 'USER': 'cltbld', 12:40:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:08 INFO - '_': '/tools/buildbot/bin/python'} 12:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 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)) 12:40:08 INFO - Cleaning up... 12:40:08 INFO - Return code: 0 12:40:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:40: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', 'jsonschema'] in /builds/slave/test/build 12:40: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 jsonschema 12:40:08 INFO - Using env: {'DISPLAY': ':0', 12:40:08 INFO - 'HOME': '/home/cltbld', 12:40:08 INFO - 'LANG': 'en_US.UTF-8', 12:40:08 INFO - 'LANGUAGE': 'en_US:en', 12:40:08 INFO - 'LOGNAME': 'cltbld', 12:40:08 INFO - 'MAIL': '/var/mail/cltbld', 12:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:08 INFO - 'MOZ_NO_REMOTE': '1', 12:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:08 INFO - 'NO_EM_RESTART': '1', 12:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:08 INFO - 'PWD': '/builds/slave/test', 12:40:08 INFO - 'SHELL': '/bin/bash', 12:40:08 INFO - 'SHLVL': '1', 12:40:08 INFO - 'TERM': 'linux', 12:40:08 INFO - 'TMOUT': '86400', 12:40:08 INFO - 'USER': 'cltbld', 12:40:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:08 INFO - '_': '/tools/buildbot/bin/python'} 12:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:08 INFO - Downloading/unpacking jsonschema 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:10 INFO - Downloading/unpacking functools32 (from jsonschema) 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40:10 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:11 INFO - warning: no files found matching '*.txt' 12:40:11 INFO - no previously-included directories found matching 'build' 12:40:11 INFO - no previously-included directories found matching 'dist' 12:40:11 INFO - no previously-included directories found matching '.git*' 12:40:11 INFO - Installing collected packages: jsonschema, functools32 12:40:11 INFO - Running setup.py install for functools32 12:40:11 INFO - warning: no files found matching '*.txt' 12:40:11 INFO - no previously-included directories found matching 'build' 12:40:11 INFO - no previously-included directories found matching 'dist' 12:40:11 INFO - no previously-included directories found matching '.git*' 12:40:11 INFO - Successfully installed jsonschema functools32 12:40:11 INFO - Cleaning up... 12:40:11 INFO - Return code: 0 12:40:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:40:11 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')]} 12:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:11 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')]} 12:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:11 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 0x7f5c6bc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', '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 12:40:11 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 12:40:11 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 12:40:11 INFO - Using env: {'DISPLAY': ':0', 12:40:11 INFO - 'HOME': '/home/cltbld', 12:40:11 INFO - 'LANG': 'en_US.UTF-8', 12:40:11 INFO - 'LANGUAGE': 'en_US:en', 12:40:11 INFO - 'LOGNAME': 'cltbld', 12:40:11 INFO - 'MAIL': '/var/mail/cltbld', 12:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:11 INFO - 'MOZ_NO_REMOTE': '1', 12:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:11 INFO - 'NO_EM_RESTART': '1', 12:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:11 INFO - 'PWD': '/builds/slave/test', 12:40:11 INFO - 'SHELL': '/bin/bash', 12:40:11 INFO - 'SHLVL': '1', 12:40:11 INFO - 'TERM': 'linux', 12:40:11 INFO - 'TMOUT': '86400', 12:40:11 INFO - 'USER': 'cltbld', 12:40:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:11 INFO - '_': '/tools/buildbot/bin/python'} 12:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:11 INFO - Downloading/unpacking flake8 12:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:40:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:40:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:13 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 12:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:14 INFO - no previously-included directories found matching 'docs/_build' 12:40:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:40:14 INFO - Running setup.py install for pep8 12:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:14 INFO - no previously-included directories found matching 'docs/_build' 12:40:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:40:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:40:14 INFO - Cleaning up... 12:40:14 INFO - Return code: 0 12:40:14 INFO - Running post-action listener: _resource_record_post_action 12:40:14 INFO - Running post-action listener: _start_resource_monitoring 12:40:14 INFO - Starting resource monitoring. 12:40:14 INFO - ##### 12:40:14 INFO - ##### Running install step. 12:40:14 INFO - ##### 12:40:14 INFO - Running pre-action listener: _resource_record_pre_action 12:40:14 INFO - Running main action method: install 12:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:14 INFO - Reading from file tmpfile_stdout 12:40:14 INFO - Detecting whether we're running mozinstall >=1.0... 12:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:40:14 INFO - Reading from file tmpfile_stdout 12:40:14 INFO - Output received: 12:40:14 INFO - Usage: mozinstall [options] installer 12:40:14 INFO - Options: 12:40:14 INFO - -h, --help show this help message and exit 12:40:14 INFO - -d DEST, --destination=DEST 12:40:14 INFO - Directory to install application into. [default: 12:40:14 INFO - "/builds/slave/test"] 12:40:14 INFO - --app=APP Application being installed. [default: firefox] 12:40:14 INFO - mkdir: /builds/slave/test/build/application 12:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:40:27 INFO - Reading from file tmpfile_stdout 12:40:27 INFO - Output received: 12:40:27 INFO - /builds/slave/test/build/application/firefox/firefox 12:40:27 INFO - Running post-action listener: _resource_record_post_action 12:40:27 INFO - ##### 12:40:27 INFO - ##### Running run-tests step. 12:40:27 INFO - ##### 12:40:27 INFO - Running pre-action listener: _resource_record_pre_action 12:40:27 INFO - Running main action method: run_tests 12:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:27 INFO - Python 2.7.3 12:40:27 INFO - Return code: 0 12:40:27 INFO - grabbing minidump binary from tooltool 12:40: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')]} 12:40: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 0x1a2d410>, '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 0x1a2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40: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 12:40: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 12:40:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:27 INFO - Return code: 0 12:40:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:40:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:40:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:40:28 INFO - Return code: 0 12:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 12:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 12:40:28 INFO - Using env: {'DISPLAY': ':0', 12:40:28 INFO - 'HOME': '/home/cltbld', 12:40:28 INFO - 'LANG': 'en_US.UTF-8', 12:40:28 INFO - 'LANGUAGE': 'en_US:en', 12:40:28 INFO - 'LOGNAME': 'cltbld', 12:40:28 INFO - 'MAIL': '/var/mail/cltbld', 12:40:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:28 INFO - 'MOZ_NO_REMOTE': '1', 12:40:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:28 INFO - 'NO_EM_RESTART': '1', 12:40:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:28 INFO - 'PWD': '/builds/slave/test', 12:40:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:28 INFO - 'SHELL': '/bin/bash', 12:40:28 INFO - 'SHLVL': '1', 12:40:28 INFO - 'TERM': 'linux', 12:40:28 INFO - 'TMOUT': '86400', 12:40:28 INFO - 'USER': 'cltbld', 12:40:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899', 12:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:28 INFO - '_': '/tools/buildbot/bin/python'} 12:40:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 12:40:29 INFO - mozversion application_buildid: 20160721073720 12:40:29 INFO - mozversion application_changeset: 6688064e8ad629276830b941df87681a21b67cdc 12:40:29 INFO - mozversion application_display_name: Firefox 12:40:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:29 INFO - mozversion application_name: Firefox 12:40:29 INFO - mozversion application_remotingname: firefox 12:40:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:40:29 INFO - mozversion application_vendor: Mozilla 12:40:29 INFO - mozversion application_version: 48.0 12:40:29 INFO - mozversion platform_buildid: 20160721073720 12:40:29 INFO - mozversion platform_changeset: 6688064e8ad629276830b941df87681a21b67cdc 12:40:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:40:29 INFO - mozversion platform_version: 48.0 12:40:29 INFO - using testdate: 1469130029 12:40:29 INFO - actual date: 1469130029 12:40:29 INFO - starting webserver on 'localhost:35123' 12:40:29 INFO - SUITE-START | Running 2 tests 12:40:29 INFO - TEST-START | dromaeo_css 12:40:29 INFO - operating with platform_type : linux_ 12:40:29 INFO - Initialising browser for dromaeo_css test... 12:40:29 INFO - TEST-INFO | started process 15363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9m_aMe/profile http://localhost:35123/getInfo.html) 12:40:32 INFO - PROCESS | 15363 | __metrics Screen width/height:1600/1200 12:40:32 INFO - PROCESS | 15363 | colorDepth:24 12:40:32 INFO - PROCESS | 15363 | Browser inner width/height: 1024/697 12:40:32 INFO - PROCESS | 15363 | __metrics 12:40:33 INFO - PROCESS | 15363 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:40:33 ERROR - PROCESS | 15363 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:40:34 INFO - TEST-INFO | 15363: exit 0 12:40:34 INFO - Browser initialized. 12:40:34 INFO - Running cycle 1/1 for dromaeo_css test... 12:40:34 INFO - TEST-INFO | started process 15452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9m_aMe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:46 INFO - PROCESS | 15452 | RSS: Main: 139608064 12:40:46 INFO - PROCESS | 15452 | 12:41:37 INFO - PROCESS | 15452 | 1469130097417 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] 12:43:45 INFO - PROCESS | 15452 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35123/tests/dromaeo/cssquery-ext.html) 12:43:46 INFO - PROCESS | 15452 | RSS: Main: 244674560 12:43:46 INFO - PROCESS | 15452 | 12:46:48 INFO - PROCESS | 15452 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-ext.html (next: http://localhost:35123/tests/dromaeo/cssquery-jquery.html) 12:46:48 INFO - PROCESS | 15452 | RSS: Main: 221880320 12:46:48 INFO - PROCESS | 15452 | 12:49:50 INFO - PROCESS | 15452 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35123/tests/dromaeo/cssquery-mootools.html) 12:49:51 INFO - PROCESS | 15452 | RSS: Main: 219713536 12:49:51 INFO - PROCESS | 15452 | 12:52:53 INFO - PROCESS | 15452 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35123/tests/dromaeo/cssquery-prototype.html) 12:52:53 INFO - PROCESS | 15452 | RSS: Main: 219889664 12:52:53 INFO - PROCESS | 15452 | 12:55:56 INFO - PROCESS | 15452 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35123/tests/dromaeo/cssquery-yui.html) 12:55:56 INFO - PROCESS | 15452 | RSS: Main: 182398976 12:55:56 INFO - PROCESS | 15452 | 12:58:58 INFO - PROCESS | 15452 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-yui.html (next: http://localhost:35123/tests/dromaeo/cssquery-dojo.html) 12:58:59 INFO - PROCESS | 15452 | RSS: Main: 255426560 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | __start_tp_report 12:58:59 INFO - PROCESS | 15452 | _x_x_mozilla_page_load 12:58:59 INFO - PROCESS | 15452 | _x_x_mozilla_page_load_details 12:58:59 INFO - PROCESS | 15452 | |i|pagename|runs| 12:58:59 INFO - PROCESS | 15452 | |0;dojo.html;3288.5724855768754;3338.983305083475;3357.9664203357975;3392.7116195123413;3397.9320413591727;5585.357683866357;5592.580556458267;5596.58025648077;5597.412271711468;5598.300212473441;5563;5608.355039170497;5611.242482264893;5619.775208991636;5651.943480565194;4950.6287028472825;4992.201247800353;5167.819126330579;5212.582993360522;5241.5806735461265;5062.468440813716;5095.133827249377;5131.050755610206;5134;5137.537621614054;5065.290859279704;5115.335006449156;5123.385193776752;5135.281060651511;5147.768350424221;5036.043151801146;5036.899262014757;5055.823046193365;5060.822871199527;5087.643864929438;4899.58353539946;4918.8278410255825;4948.38145231846;4949.950500494985;4970.378702662168;5316.5746740261075;5368.248445217672;5376.247325374451;5384.542313903323;5396.487333703292;5904.055351143839;5963.314218864843;5963.671998040106;5966.0454327307425;5970;5965.850853728692;5990.371011043821;6059.606125601866;6063.211782468295;6096.573239873211;5618.578606604521;5621.971890140564;5637.548996080344;5639.605227634108;5650.858728531778;5951.166836642873;6150.661713605795;6152.569320147547;6155.938440615537;6157;5832.212651292106;5918.437748413894;5921.792737254175;5935.317438494542;5937.732802023919;5892.764289428461;5893.823185304448;5895.705214739246;5902.468777810018;5906.49794767441;5740.827775166752;5831.183634291203;5872.0898260769645;5874.73563689635;5879.559033072536;5940.227770389908;5959.493443057302;5964.194833697482;5970.820875373745;6003.249593800775;4540.409746732969;4550.954490455119;4551.95448045522;4553.248713962159;4579.290210017452;4001.979990100031;4002.539707933625;4069.5116586009276;4078.4494093297617;4124.752514849119;5710.857228569319;5712.571557133231;5728.1694154348215;5731.512821410143;5735.1970724098655;5959.433853783884;5995.61028533144;6012.789552365646;6014.609050411709;6021.307549631849;5526.889462210734;5635.633683810539;5701.629394089371;5717.514011309002;5739.971300143473;5076.898462030738;5078.644494885322;5079.6698214615935;5079.771410286546;5099.719515426687;6258.217722784652;6263.561550691499;6264.968675156595;6266.091416744546;6276.968615156895;5789.044807606866;5948.345681975065;5989.281286245591;6001.219841420588;6031.09533569968;6212.844678883064;6235.657038862906;6246.718897649707;6249.750009999549;6254.155688982111;5878.470937615464;5885.73514191871;5886.38192989747;5886.6173698709445;5921.5558833086825;5826.6504009757855;5934.228550288435;5988.161657367885;6039.577229594062;6043.395660433922;5854.912176317273;5863.120531920075;5874.295084589877;5879.617824841543;5879.94120058811;5787.9421205789085;5834.591578589458;5849;5851.64890106578;5855.180274761622;5598.048331783688;5710.200571920018;5771.797987070432;5781.277340332458;5792.015357389169;5816.069428891357;5831.4168583141345;5839.562032847469;5869.35437101927;5881.264841894763;5642.294713160855;5743.827685169452;5747.683877386617;5747.712614369349;5772.134179873053 12:58:59 INFO - PROCESS | 15452 | |1;ext.html;658.7957733102738;668.4958842604141;669.3139531979721;677.0555075669445;679.6601699150425;31592.68407315929;32209.67790322099;41064.58935410645;41738.7913060435;41843.372349414705;43171.35242971358;43549.7822510887;43585.78207108968;43663;43683.34474982878;7735.690572377098;8788.209061184492;9045.095490450967;9047.954760226223;10383.221258405612;10458.215633827454;10598.894011059907;10602.151827853753;10604.363738175734;10605;10659.573617055308;10753.139748820115;10753.78492430151;10755.677329680084;10758.677239682784;10568.577256909753;10618.78762424751;10630.149588032938;10636.255462117655;10641.467926603638;10579.047885690248;11000;11003.449827508593;11011;11012.779744405147;43801;44307;44348.77825610884;44361.556384436386;44416.3337549937;3912.100216950089;4063.817128229237;4196.874093777192;4209.621134097946;4753.3582966299455;31127.533087003714;31315;31413.214669633442;31542.211444713837;32521.51217731736;4244.490661120685;4378.6934914555995;4431.180231657154;4481.641468682497;4619.8152073917;210427;211708;211906;212544.99999999846;212579;39381;57624;62756.686216568625;63278.367216328166;63378.049329260095;38450.807745961094;38519.614803852164;38569.228615428096;38596.61403385986;38654;15821.367145314289;17111;17284.567885802702;17385.130743462778;17387.65224695499;14735.189564573837;14930.925345373204;15039.924800375928;15053.623659408384;15079.849201507845;9318.161365477139;9382.437053776659;9384.90615093854;9462.716118516455;9481.573329200202;3597.334493118781;3684.6683798458266;3707.0917625182;3717.20080182762;3755.5681096673684;1126.3185772607455;1136.710138914588;1209.1596340543415;1211.206639795094;1301.811237370576;33525.161870952936;33793;34092.31815363679;34332.82833585816;35538.822305888825;1188.8335633011386;1222.7676741419102;1230.8584512781144;1317.80232965056;1331.9533816316382;17777.46667599974;18517.166727497024;18757.624847503248;18775.812241877407;18831.90584047071;480456;484183;484849;485087;485908;63554.364456354844;64023.67988160029;64434.67782661057;64439.67780161069;64454.677726611066;1361.1356788439412;1491.7762335649738;1500.4748338081583;1501.054335768459;1546.2500687166714;30539;30833.075007748907;31652.208694781893;32206.67793322037;32679.673203267663;50898.74550627223;52405;52410;52422.47577524176;52501;301776;303913;304452;304985;306328;27723.722762772115;31427.528587070756;49870.251946221564;50274.24588631246;50987.235191471416;50530.49469505258;50736;50802.74598626983;51098.74450627723;51434;43812.78093609639;43874;44375.334369985125;44866.77566612146;45672;43733.34399984066;44578.3313250295;44607.55392446164;45001.77499112614;46978.53021469741;45541.31688024748;45810.31284530668;46918.76540617275;47147.292790607484;47149;39643.405348919216;40409.39385909155;40535.59464405436;40613.79693101515;41375.7931210342;30259.243518912204;30776.69223307738;30940.53589196209;30971;31257.8437107813 12:58:59 INFO - PROCESS | 15452 | |2;jquery.html;409.75619506393684;411.2433123053581;426.24129050290475;436.5983295368261;436.7423220300024;14635.92682036591;19000.14499347531;19634.410967670956;19651.410457686256;20362.287319943804;15075.321610527526;19155;19507.317243896465;19927.501812454695;20818.89590552049;5559.972200139004;5734.569907256951;5748.080307150857;5769.04810706233;5774.018416869142;5620.690862002588;5688.544916406699;5694.829155125353;5695.174199741055;5698.173764804101;5587;5653.886922261552;5667.773289068432;5673.12066629671;5673.404292549285;5620.606557540974;5727.656340619535;5762.3373312069225;5781.39295373986;5786.392428794979;5143.614228932845;5175.508326708957;5182.792688292464;5197.428282888879;5230.953809238167;23777.88111059451;23937.64093538598;24562;24570.262892113264;24687.62968555473;2479.7024357077084;2500.087468074158;2826.6325377700973;2855;2925.0639795265524;14522.273886305642;15110.622234444118;15204;15262.31319590621;15535.766963495556;2042.5710600773855;2078.262216912989;2087.6242276390244;2103.8842863642494;2130.1585873579847;77800.61099694522;78391.60804195999;79377;79902;80610.19389806085;10831;10931.453427328603;11200.431939528473;11231.326120432801;11397.772044559062;15451.072935623899;15515.922420387826;15559.29983150761;15701.764473532907;15711.371545138296;8645.13548645143;8731.519766412908;8779.736607901774;8797;8798.164174403422;8466.957665211758;8471.534065626327;8546.572671366406;8613.48319100856;8617.138286171332;6210.72051757672;6926.896096558556;7029.3673569379;7053.470989675795;7103.538270012433;1831.8134555205654;1989.1365611080769;1993.8205561499535;1999.8700084494462;2016.7882372350984;1035.1977217656377;1121.5233525751523;1148.4602236948622;1179.7050737315672;1196.8683444821063;19448.319308824408;19616;19781.802181978284;19838.90080549588;19972.600547988957;1110.1285490889613;1148.4831825678311;1169.0939521870448;1180.1620849196995;1216.0271782574082;11247.887521124683;11338.886611133783;11520.193586449035;11543.826842597367;11546.653600392001;380662;382465;385627;386251;512400;91283.54358228167;98469.50765246128;99514;99741.50129249452;99754.5012274934;1130.0846314485293;1145.3498794892596;1146.4267866066966;1150.896419322265;1163.0637336943842;17301.62218315495;17750.023748693944;17755.733663994793;17802.37691680785;18254.72617910759;40026.799866001646;40079.99800005023;40379.798101010485;40719.389209161294;41138.38292425556;57518;59419.70290148695;59875.700621498356;60012.69993650004;60074;8663.783405414915;8834.381593288408;8836.469811811312;8938.329625278;8961.014288428398;9281.814363712552;12781.744365112832;13185.340732963505;13476.124051936593;13541.052126351455;11577.247478913843;11614.419279035845;11715.355655439032;12145;12150.939245303716;11483.138764592522;11546.94226528862;11721.824172637587;11727.882721172678;11937.164398492023;11861.881381186422;11972.401379930794;12125.575604853788;12312.50749970027;12390.75218495607;8563.61463734146;8570.100139485265;8616.612252448529;8622.525761083201;8927.642894284416;11402.771944560896;11987.100967427303;12007.39963001829;12014.459349329127;12118.151729378858 12:58:59 INFO - PROCESS | 15452 | |3;mootools.html;1383.5780087073438;1542.9382824687013;1556.3307777655607;1742.9912850435746;1898.079431475734;7142.25006374331;7978.6808527658895;8119.959400203005;8137.755867323975;8159.22487363701;8065.879011814813;8070.354371650268;8135.145809689986;8141.307988820958;8170.223828736261;2354.0701422937886;2375.192434572245;2376.310869847742;2377.1561095811;2377.3224630980176;2367.739548649647;2386.6181410974245;2414.263649586875;2416.4079800448912;2422.6002709552904;2386.725526564441;2411.4212588978694;2413.5776239158163;2426.9271921842374;2445.5231229910173;2367.739548649647;2376.5246950609862;2378.916737914173;2381.4641705616273;2442.7312995570474;2374.4776149247136;2391.485830546441;2399.6280576510667;2404.326788499223;2405.9518809623883;7994.480358776661;8308.252257296872;8342.499450033018;8345.207205315486;8350.331973442171;5187.688738675653;5252.71110088945;5259.368875734898;5301.946980530184;5305.814296499604;3433.53647257622;3489.45913383426;3512.2799826035603;3620.5836328821997;3631.8365673544754;1191.48170545812;1196.497471062156;1202.140469564257;1227.9938600306941;1246.9688257793537;11200.719982000433;11304.37825919574;11544.30734155945;11646.068314534818;11650.70873228176;4414.404055452473;4560.429946256718;4566.70316429431;4585.312203169551;4588.587027167571;9355.204807591295;9390.248780097576;9409.76475588102;9414.811703766023;9418.152366287068;5239.345081864767;5275.788968441219;5285.524302812765;5289.894202115936;5296.947030529645;4125.339945608748;4272.380504826782;4704.03567268716;4730.077634861169;4891.315215869781;3794.2411517696573;3811.7331786774657;3862.5364956205435;3880.3209438348176;3920.666743326792;1144.9026832719146;1146.529922731676;1148.6726283009302;1148.7765529710832;1173.4836671864352;1032.7573020340214;1050.0444595418285;1050.1703654113317;1067.8344856547092;1073.75303680154;5859.267591551056;5990.700464976734;6055.5458340623745;6112.663803490851;6157.4458298753325;475.08546048855817;479.144726662912;483.58170182791633;488.39682991505464;490.05174986401425;3845;3872.8063596820048;4033.596640335943;4092.6112019358116;4119;10141.087302142843;10339.121174700234;10435.217358698128;10479.42363170033;10490.265681402381;10239.539220735085;10291.53688084038;10301.124404425558;10303.072723454925;10313.587456501657;7711.344535714415;7727.150013498511;7783.805404864924;7806.219378062148;7807.6486558105025;5695.145728140812;5710.086386178192;5837.5038121758425;5896.351401345934;5904.409559044061;8805.075467076122;8863.64545418176;8994.640214391613;8997.100289970951;9016.81966360656;8859.60131794058;8903.421277616933;9066.410683305565;9084.454932704059;9092.227160691415;6644.4020038196795;6841.8973715395305;7284.635768211674;7608.201138880338;7738.729144479917;8012.799680008046;8040.276375126266;8042.356611471186;8052.87920681202;8074.87887681697;7180;7275.818104547428;7323.340899319087;7390.5196162249285;7479.813004674927;7022.403095736715;7025.192102908027;7083.610401427764;7096.077509923884;7121.608311542915;6931.584104953719;6987.441004719712;6988.301169882971;6996;7002;4865.7323847188745;5027.170516864677;5039.84880453587;5045.066662667418;5111.258867464123;5204.0892843752945;5240.2663627093;5256.553192978639;5397.109476936262;5410.48600382963 12:58:59 INFO - PROCESS | 15452 | |4;prototype.html;334.69709912529163;337.7585026705905;350.8299820099966;363.0904584017037;363.23357715220897;6143.354947730491;6154.169187159732;6201.441870231678;6202.875942481148;6216.347283535231;5794.420557944203;5912.260967379078;5993.46058854703;6056.454919057284;6105.725242364093;4710.081534100852;4727.858164255078;4748.548887855648;4764.332993380929;4775.092732380854;4767.666263361566;4771.165046116916;4774.427068751755;4788.952110478903;4793.5925446337105;4522.751248681321;4606.239970404879;4708.246680531116;4719;4724.1260366832075;4690.788914498856;4697.224957881946;4712.410948631421;4714.90570188596;4719.221328480797;4158.022864626811;4162.125953549758;4166.375043743433;4168.24971505129;4170.895727606804;5884.823455296348;5888.499477544414;5890.676012819294;5891.528677705774;5892.175095486592;5430.67415955044;5438.749087709809;5445.101558242885;5445.727713614343;5445.754941027663;6158.199434073542;6366.586171898812;6376.872462550723;6435.517336199804;6444.838879028015;4471.955280447187;4496.123255965088;4496.730196188207;4509.503954564995;4515.887102822423;6655.567388119756;6688.498362622774;6719.126513553256;6719.160104986877;6721.327867213288;4573.679842411066;4605.6085232755595;4609.907801843944;4613.561711637389;4615.561521655437;4659.697119687209;4669.60308373792;4670.252759558454;4672.112298663243;4672.135654903854;5248.396434410015;5318.175682769177;5362.946370536322;5367.75845086972;5384.300040994645;6452.774152904626;6474.902876456857;6478.255000674889;6479.125318082093;6491.772787952494;1533.0571698405624;1591.8885678002428;1616.6605012947177;1634.1012443156453;1635.852773250413;1060.7825395793843;1076.6070384309671;1077.946102694862;1083.090204228452;1085.6580177244143;6185.350538193515;6260.40526150015;6260.561760676709;6266.530010249158;6272.3100458949475;6591.143151390384;6601.735930562723;6605.966970165118;6606.8348291293105;6611.900821487681;6240.625562466266;6253.405926436982;6255.155554000243;6259.217597800275;6260.186175797117;3543.4684797280615;3558.377283975294;3562.7684200526883;3563.518924945099;3569.339672160607;6788.558743681645;6940;6943.097397338414;6951.826204344932;6955.965220173968;6631.734730610721;6676.065350850885;6679.332066793282;6680.198376194888;6692.263850976388;6916.654167291716;6922.653867306614;6929.5842249465195;6936.34104760047;6936.994135850375;6586.736530538917;6590.736370545316;6591.835204119743;6592.406683398517;6594.274629790815;6332.145160403471;6493.967530162319;6495.772647957298;6504.414602685781;6568.7372505099265;6891.27641597625;6918.515703900679;6918.619475928671;6925.792226233221;6941.965290173517;4577.084583083463;4579.816807327803;4583.54164583539;4591.609713174284;4592.908141837078;6383.904241436289;6582.80251592453;6585.111010013587;6589.670516474253;6590.703418346282;6356.078368636614;6526.836829079121;6539.11721917535;6540.215174179129;6546.345365463416;6503.934960650333;6521.836954076186;6528.477721782341;6536.934630653823;6541.771038013647;6426.550141490051;6430.099786030053;6430.389113034442;6431.324710905287;6435.356464353715;6459.515536334699;6572.079908812674;6584.374484423972;6591.209054913249;6593.340665933369;6385.776497822554;6390.392912673288;6393.392627700361;6393.744250230125;6393.904091438539 12:58:59 INFO - PROCESS | 15452 | |5;yui.html;843.924046835785;859.4886042804533;861.7285555050163;902.318749344245;926.0554234680624;14134.0812847165;15141.16723580204;15382.230888455575;16878;17621.823781762178;15243.31405086771;15297.770533441979;15360.692786144298;15386.846131538681;15392.076475411455;730.8355619985488;913.4610579757925;917.9311551633621;923.5705396990398;944.9574769135405;921.8386782313102;924.3714274293478;926.5784068248964;929.8233335666235;930.418488444722;977.252401912534;985.960561577536;986.5856340337076;987.2250283527433;987.4026214140414;748.4685873030155;950.5959967014061;981.8379967305386;984.807962447323;986.1519093579516;713.4292565947221;714.8748968930416;715.3597530210433;715.4348065028621;715.5456285258846;15702.293396797057;15776.526704198892;15777;15799.763003554956;15812.13033283169;14551.854481455155;14730.852691473056;14782;14843.703125937422;15010.849891501055;11857.110716696283;11895.702607434883;12111.697207569792;12123.515059397614;12263.816042759276;4073.2668119738437;4075.9592404075875;4092.5907409259135;4121.52602450716;4180.686448516373;55040;55100.448995509934;55213.72393138049;55239.447605524234;55659;11303.265287756269;11340.262882912584;11344.205905586694;11702.473388697528;11751.764964700658;20140.496487587927;20145.194192232146;20185.59628807445;20197.596048078954;20198.192072316942;8459.154084591491;8472.068072512018;8542.18849209324;8658.437201581877;8755.387122901337;4907.2393778964315;4915.3855768029;4919.163742163841;4944.653874228769;5216.817411390659;3789.317922773872;3848.0956975110826;3849.557300910375;3849.826757795906;3855.749376290532;687.8933765266391;689.1248114894056;689.19020151323;705.5096707788141;726.3136336162275;839.4669384940606;869.799946012408;871.1201686296886;874.2437791310598;877.6006916852816;9446.38598491096;9467.952660236655;9511;9596;9701.126898579161;830.7923019245188;837.5058715357968;843.2705709561185;858.4763294390417;866.1771317248639;4723.7638118093955;4742.905141897143;4813.446453657804;4844.32179494871;4956.479569645207;59856.40143598595;59974.70012649996;60203.69898150569;60354.396456035756;67789.32210677929;52971.47028529742;53053;53468;54345;54426;52524.737376313635;52928.73535632297;53081;53270.467295327326;53702;10004.749881253027;10024.548895299584;10038.347507411994;10190.1338386238;10266.743331416774;36821.26357472889;38111;38246.42630360491;39333.80333098316;39602.60397395989;44595.331070033324;48144.51855481401;51555.22667159921;51943.22085168801;53132.734336328074;11617.244879082833;12034.277943323428;12293;12722.745545089232;12826.102172847812;12464.314462704275;13692.041557091306;14526.564203073925;14852.480163194236;15056.548303550911;12957;13872.375743091383;13955.37200825945;14129.646758831112;14145;13348.866511334762;13687.726245475234;13816.516421925184;13846.861531384557;14190.57428277112;13499.730005400033;13613.387397566936;13707.725845482835;13910.443582256596;13968.441262349392;11279.32324060559;11399.658010259705;11620.925817321564;11621.302721836379;11880.643580692593;11237.3257604544;11479.024282936043;11565.537378505102;12355.135140540076;12423.192492487959 12:58:59 INFO - PROCESS | 15452 | __end_tp_report 12:58:59 INFO - PROCESS | 15452 | __start_cc_report 12:58:59 INFO - PROCESS | 15452 | _x_x_mozilla_cycle_collect,806 12:58:59 INFO - PROCESS | 15452 | __end_cc_report 12:58:59 INFO - PROCESS | 15452 | __startTimestamp1469131139148__endTimestamp 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | ------- Summary: start ------- 12:58:59 INFO - PROCESS | 15452 | Number of tests: 6 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | [#0] dojo.html Cycles:165 Average:5546.28 Median:5771.80 stddev:624.90 (10.8%) stddev-sans-first:601.19 12:58:59 INFO - PROCESS | 15452 | Values: 3288.6 3339.0 3358.0 3392.7 3397.9 5585.4 5592.6 5596.6 5597.4 5598.3 5563.0 5608.4 5611.2 5619.8 5651.9 4950.6 4992.2 5167.8 5212.6 5241.6 5062.5 5095.1 5131.1 5134.0 5137.5 5065.3 5115.3 5123.4 5135.3 5147.8 5036.0 5036.9 5055.8 5060.8 5087.6 4899.6 4918.8 4948.4 4950.0 4970.4 5316.6 5368.2 5376.2 5384.5 5396.5 5904.1 5963.3 5963.7 5966.0 5970.0 5965.9 5990.4 6059.6 6063.2 6096.6 5618.6 5622.0 5637.5 5639.6 5650.9 5951.2 6150.7 6152.6 6155.9 6157.0 5832.2 5918.4 5921.8 5935.3 5937.7 5892.8 5893.8 5895.7 5902.5 5906.5 5740.8 5831.2 5872.1 5874.7 5879.6 5940.2 5959.5 5964.2 5970.8 6003.2 4540.4 4551.0 4552.0 4553.2 4579.3 4002.0 4002.5 4069.5 4078.4 4124.8 5710.9 5712.6 5728.2 5731.5 5735.2 5959.4 5995.6 6012.8 6014.6 6021.3 5526.9 5635.6 5701.6 5717.5 5740.0 5076.9 5078.6 5079.7 5079.8 5099.7 6258.2 6263.6 6265.0 6266.1 6277.0 5789.0 5948.3 5989.3 6001.2 6031.1 6212.8 6235.7 6246.7 6249.8 6254.2 5878.5 5885.7 5886.4 5886.6 5921.6 5826.7 5934.2 5988.2 6039.6 6043.4 5854.9 5863.1 5874.3 5879.6 5879.9 5787.9 5834.6 5849.0 5851.6 5855.2 5598.0 5710.2 5771.8 5781.3 5792.0 5816.1 5831.4 5839.6 5869.4 5881.3 5642.3 5743.8 5747.7 5747.7 5772.1 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | [#1] ext.html Cycles:180 Average:51786.64 Median:38485.21 stddev:93085.68 (241.9%) stddev-sans-first:93267.66 12:58:59 INFO - PROCESS | 15452 | Values: 658.8 668.5 669.3 677.1 679.7 31592.7 32209.7 41064.6 41738.8 41843.4 43171.4 43549.8 43585.8 43663.0 43683.3 7735.7 8788.2 9045.1 9048.0 10383.2 10458.2 10598.9 10602.2 10604.4 10605.0 10659.6 10753.1 10753.8 10755.7 10758.7 10568.6 10618.8 10630.1 10636.3 10641.5 10579.0 11000.0 11003.4 11011.0 11012.8 43801.0 44307.0 44348.8 44361.6 44416.3 3912.1 4063.8 4196.9 4209.6 4753.4 31127.5 31315.0 31413.2 31542.2 32521.5 4244.5 4378.7 4431.2 4481.6 4619.8 210427.0 211708.0 211906.0 212545.0 212579.0 39381.0 57624.0 62756.7 63278.4 63378.0 38450.8 38519.6 38569.2 38596.6 38654.0 15821.4 17111.0 17284.6 17385.1 17387.7 14735.2 14930.9 15039.9 15053.6 15079.8 9318.2 9382.4 9384.9 9462.7 9481.6 3597.3 3684.7 3707.1 3717.2 3755.6 1126.3 1136.7 1209.2 1211.2 1301.8 33525.2 33793.0 34092.3 34332.8 35538.8 1188.8 1222.8 1230.9 1317.8 1332.0 17777.5 18517.2 18757.6 18775.8 18831.9 480456.0 484183.0 484849.0 485087.0 485908.0 63554.4 64023.7 64434.7 64439.7 64454.7 1361.1 1491.8 1500.5 1501.1 1546.3 30539.0 30833.1 31652.2 32206.7 32679.7 50898.7 52405.0 52410.0 52422.5 52501.0 301776.0 303913.0 304452.0 304985.0 306328.0 27723.7 31427.5 49870.3 50274.2 50987.2 50530.5 50736.0 50802.7 51098.7 51434.0 43812.8 43874.0 44375.3 44866.8 45672.0 43733.3 44578.3 44607.6 45001.8 46978.5 45541.3 45810.3 46918.8 47147.3 47149.0 39643.4 40409.4 40535.6 40613.8 41375.8 30259.2 30776.7 30940.5 30971.0 31257.8 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | [#2] jquery.html Cycles:180 Average:27200.88 Median:24249.82 stddev:68642.98 (283.1%) stddev-sans-first:68806.07 12:58:59 INFO - PROCESS | 15452 | Values: 409.8 411.2 426.2 436.6 436.7 14635.9 19000.1 19634.4 19651.4 20362.3 15075.3 19155.0 19507.3 19927.5 20818.9 5560.0 5734.6 5748.1 5769.0 5774.0 5620.7 5688.5 5694.8 5695.2 5698.2 5587.0 5653.9 5667.8 5673.1 5673.4 5620.6 5727.7 5762.3 5781.4 5786.4 5143.6 5175.5 5182.8 5197.4 5231.0 23777.9 23937.6 24562.0 24570.3 24687.6 2479.7 2500.1 2826.6 2855.0 2925.1 14522.3 15110.6 15204.0 15262.3 15535.8 2042.6 2078.3 2087.6 2103.9 2130.2 77800.6 78391.6 79377.0 79902.0 80610.2 10831.0 10931.5 11200.4 11231.3 11397.8 15451.1 15515.9 15559.3 15701.8 15711.4 8645.1 8731.5 8779.7 8797.0 8798.2 8467.0 8471.5 8546.6 8613.5 8617.1 6210.7 6926.9 7029.4 7053.5 7103.5 1831.8 1989.1 1993.8 1999.9 2016.8 1035.2 1121.5 1148.5 1179.7 1196.9 19448.3 19616.0 19781.8 19838.9 19972.6 1110.1 1148.5 1169.1 1180.2 1216.0 11247.9 11338.9 11520.2 11543.8 11546.7 380662.0 382465.0 385627.0 386251.0 512400.0 91283.5 98469.5 99514.0 99741.5 99754.5 1130.1 1145.3 1146.4 1150.9 1163.1 17301.6 17750.0 17755.7 17802.4 18254.7 40026.8 40080.0 40379.8 40719.4 41138.4 57518.0 59419.7 59875.7 60012.7 60074.0 8663.8 8834.4 8836.5 8938.3 8961.0 9281.8 12781.7 13185.3 13476.1 13541.1 11577.2 11614.4 11715.4 12145.0 12150.9 11483.1 11546.9 11721.8 11727.9 11937.2 11861.9 11972.4 12125.6 12312.5 12390.8 8563.6 8570.1 8616.6 8622.5 8927.6 11402.8 11987.1 12007.4 12014.5 12118.2 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | [#3] mootools.html Cycles:180 Average:5523.79 Median:2758.61 stddev:2998.86 (108.7%) stddev-sans-first:2991.12 12:58:59 INFO - PROCESS | 15452 | Values: 1383.6 1542.9 1556.3 1743.0 1898.1 7142.3 7978.7 8120.0 8137.8 8159.2 8065.9 8070.4 8135.1 8141.3 8170.2 2354.1 2375.2 2376.3 2377.2 2377.3 2367.7 2386.6 2414.3 2416.4 2422.6 2386.7 2411.4 2413.6 2426.9 2445.5 2367.7 2376.5 2378.9 2381.5 2442.7 2374.5 2391.5 2399.6 2404.3 2406.0 7994.5 8308.3 8342.5 8345.2 8350.3 5187.7 5252.7 5259.4 5301.9 5305.8 3433.5 3489.5 3512.3 3620.6 3631.8 1191.5 1196.5 1202.1 1228.0 1247.0 11200.7 11304.4 11544.3 11646.1 11650.7 4414.4 4560.4 4566.7 4585.3 4588.6 9355.2 9390.2 9409.8 9414.8 9418.2 5239.3 5275.8 5285.5 5289.9 5296.9 4125.3 4272.4 4704.0 4730.1 4891.3 3794.2 3811.7 3862.5 3880.3 3920.7 1144.9 1146.5 1148.7 1148.8 1173.5 1032.8 1050.0 1050.2 1067.8 1073.8 5859.3 5990.7 6055.5 6112.7 6157.4 475.1 479.1 483.6 488.4 490.1 3845.0 3872.8 4033.6 4092.6 4119.0 10141.1 10339.1 10435.2 10479.4 10490.3 10239.5 10291.5 10301.1 10303.1 10313.6 7711.3 7727.2 7783.8 7806.2 7807.6 5695.1 5710.1 5837.5 5896.4 5904.4 8805.1 8863.6 8994.6 8997.1 9016.8 8859.6 8903.4 9066.4 9084.5 9092.2 6644.4 6841.9 7284.6 7608.2 7738.7 8012.8 8040.3 8042.4 8052.9 8074.9 7180.0 7275.8 7323.3 7390.5 7479.8 7022.4 7025.2 7083.6 7096.1 7121.6 6931.6 6987.4 6988.3 6996.0 7002.0 4865.7 5027.2 5039.8 5045.1 5111.3 5204.1 5240.3 5256.6 5397.1 5410.5 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | [#4] prototype.html Cycles:180 Average:5414.48 Median:6209.61 stddev:1622.63 (26.1%) stddev-sans-first:1581.75 12:58:59 INFO - PROCESS | 15452 | Values: 334.7 337.8 350.8 363.1 363.2 6143.4 6154.2 6201.4 6202.9 6216.3 5794.4 5912.3 5993.5 6056.5 6105.7 4710.1 4727.9 4748.5 4764.3 4775.1 4767.7 4771.2 4774.4 4789.0 4793.6 4522.8 4606.2 4708.2 4719.0 4724.1 4690.8 4697.2 4712.4 4714.9 4719.2 4158.0 4162.1 4166.4 4168.2 4170.9 5884.8 5888.5 5890.7 5891.5 5892.2 5430.7 5438.7 5445.1 5445.7 5445.8 6158.2 6366.6 6376.9 6435.5 6444.8 4472.0 4496.1 4496.7 4509.5 4515.9 6655.6 6688.5 6719.1 6719.2 6721.3 4573.7 4605.6 4609.9 4613.6 4615.6 4659.7 4669.6 4670.3 4672.1 4672.1 5248.4 5318.2 5362.9 5367.8 5384.3 6452.8 6474.9 6478.3 6479.1 6491.8 1533.1 1591.9 1616.7 1634.1 1635.9 1060.8 1076.6 1077.9 1083.1 1085.7 6185.4 6260.4 6260.6 6266.5 6272.3 6591.1 6601.7 6606.0 6606.8 6611.9 6240.6 6253.4 6255.2 6259.2 6260.2 3543.5 3558.4 3562.8 3563.5 3569.3 6788.6 6940.0 6943.1 6951.8 6956.0 6631.7 6676.1 6679.3 6680.2 6692.3 6916.7 6922.7 6929.6 6936.3 6937.0 6586.7 6590.7 6591.8 6592.4 6594.3 6332.1 6494.0 6495.8 6504.4 6568.7 6891.3 6918.5 6918.6 6925.8 6942.0 4577.1 4579.8 4583.5 4591.6 4592.9 6383.9 6582.8 6585.1 6589.7 6590.7 6356.1 6526.8 6539.1 6540.2 6546.3 6503.9 6521.8 6528.5 6536.9 6541.8 6426.6 6430.1 6430.4 6431.3 6435.4 6459.5 6572.1 6584.4 6591.2 6593.3 6385.8 6390.4 6393.4 6393.7 6393.9 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - PROCESS | 15452 | [#5] yui.html Cycles:180 Average:15616.67 Median:24659.55 stddev:17482.50 (70.9%) stddev-sans-first:17496.34 12:58:59 INFO - PROCESS | 15452 | Values: 843.9 859.5 861.7 902.3 926.1 14134.1 15141.2 15382.2 16878.0 17621.8 15243.3 15297.8 15360.7 15386.8 15392.1 730.8 913.5 917.9 923.6 945.0 921.8 924.4 926.6 929.8 930.4 977.3 986.0 986.6 987.2 987.4 748.5 950.6 981.8 984.8 986.2 713.4 714.9 715.4 715.4 715.5 15702.3 15776.5 15777.0 15799.8 15812.1 14551.9 14730.9 14782.0 14843.7 15010.8 11857.1 11895.7 12111.7 12123.5 12263.8 4073.3 4076.0 4092.6 4121.5 4180.7 55040.0 55100.4 55213.7 55239.4 55659.0 11303.3 11340.3 11344.2 11702.5 11751.8 20140.5 20145.2 20185.6 20197.6 20198.2 8459.2 8472.1 8542.2 8658.4 8755.4 4907.2 4915.4 4919.2 4944.7 5216.8 3789.3 3848.1 3849.6 3849.8 3855.7 687.9 689.1 689.2 705.5 726.3 839.5 869.8 871.1 874.2 877.6 9446.4 9468.0 9511.0 9596.0 9701.1 830.8 837.5 843.3 858.5 866.2 4723.8 4742.9 4813.4 4844.3 4956.5 59856.4 59974.7 60203.7 60354.4 67789.3 52971.5 53053.0 53468.0 54345.0 54426.0 52524.7 52928.7 53081.0 53270.5 53702.0 10004.7 10024.5 10038.3 10190.1 10266.7 36821.3 38111.0 38246.4 39333.8 39602.6 44595.3 48144.5 51555.2 51943.2 53132.7 11617.2 12034.3 12293.0 12722.7 12826.1 12464.3 13692.0 14526.6 14852.5 15056.5 12957.0 13872.4 13955.4 14129.6 14145.0 13348.9 13687.7 13816.5 13846.9 14190.6 13499.7 13613.4 13707.7 13910.4 13968.4 11279.3 11399.7 11620.9 11621.3 11880.6 11237.3 11479.0 11565.5 12355.1 12423.2 12:58:59 INFO - PROCESS | 15452 | -------- Summary: end -------- 12:58:59 INFO - PROCESS | 15452 | 12:58:59 INFO - TEST-INFO | 15452: exit 0 12:58:59 INFO - TEST-OK | dromaeo_css | took 1110748ms 12:58:59 INFO - TEST-START | kraken 12:58:59 INFO - operating with platform_type : linux_ 12:58:59 INFO - Initialising browser for kraken test... 12:58:59 INFO - TEST-INFO | started process 15646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsz3liQ/profile http://localhost:35123/getInfo.html) 12:59:03 INFO - PROCESS | 15646 | __metrics Screen width/height:1600/1200 12:59:03 INFO - PROCESS | 15646 | colorDepth:24 12:59:03 INFO - PROCESS | 15646 | Browser inner width/height: 1024/697 12:59:03 INFO - PROCESS | 15646 | __metrics 12:59:04 INFO - PROCESS | 15646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:59:04 ERROR - PROCESS | 15646 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:59:05 INFO - TEST-INFO | 15646: exit 0 12:59:05 INFO - Browser initialized. 12:59:05 INFO - Running cycle 1/1 for kraken test... 12:59:05 INFO - TEST-INFO | started process 15737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsz3liQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:16 INFO - PROCESS | 15737 | RSS: Main: 140017664 12:59:16 INFO - PROCESS | 15737 | 12:59:19 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-beat-detection) 12:59:20 INFO - PROCESS | 15737 | RSS: Main: 197173248 12:59:20 INFO - PROCESS | 15737 | 12:59:22 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-dft) 12:59:23 INFO - PROCESS | 15737 | RSS: Main: 184156160 12:59:23 INFO - PROCESS | 15737 | 12:59:26 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-fft) 12:59:26 INFO - PROCESS | 15737 | RSS: Main: 272924672 12:59:26 INFO - PROCESS | 15737 | 12:59:28 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-oscillator) 12:59:29 INFO - PROCESS | 15737 | RSS: Main: 178782208 12:59:29 INFO - PROCESS | 15737 | 12:59:31 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35123/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:32 INFO - PROCESS | 15737 | RSS: Main: 177938432 12:59:32 INFO - PROCESS | 15737 | 12:59:35 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35123/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:35 INFO - PROCESS | 15737 | RSS: Main: 212250624 12:59:35 INFO - PROCESS | 15737 | 12:59:39 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35123/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:39 INFO - PROCESS | 15737 | RSS: Main: 212680704 12:59:39 INFO - PROCESS | 15737 | 12:59:42 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35123/tests/kraken/driver.html?testName=json-parse-financial) 12:59:43 INFO - PROCESS | 15737 | RSS: Main: 212549632 12:59:43 INFO - PROCESS | 15737 | 12:59:44 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35123/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:45 INFO - PROCESS | 15737 | RSS: Main: 195973120 12:59:45 INFO - PROCESS | 15737 | 12:59:46 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:47 INFO - PROCESS | 15737 | RSS: Main: 198615040 12:59:47 INFO - PROCESS | 15737 | 12:59:49 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:50 INFO - PROCESS | 15737 | RSS: Main: 209952768 12:59:50 INFO - PROCESS | 15737 | 12:59:52 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:59:53 INFO - PROCESS | 15737 | RSS: Main: 218906624 12:59:53 INFO - PROCESS | 15737 | 12:59:55 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:59:56 INFO - PROCESS | 15737 | RSS: Main: 215379968 12:59:56 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35123/tests/kraken/driver.html?testName=ai-astar) 12:59:58 INFO - PROCESS | 15737 | RSS: Main: 275927040 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | __start_tp_report 12:59:58 INFO - PROCESS | 15737 | _x_x_mozilla_page_load 12:59:58 INFO - PROCESS | 15737 | _x_x_mozilla_page_load_details 12:59:58 INFO - PROCESS | 15737 | |i|pagename|runs| 12:59:58 INFO - PROCESS | 15737 | |0;ai-astar;112;112;112;111;111;111;105;111;111;111 12:59:58 INFO - PROCESS | 15737 | |1;audio-beat-detection;155;126;159;183;136;153;163;127;177;125 12:59:58 INFO - PROCESS | 15737 | |2;audio-dft;160;159;159;159;162;159;161;160;159;160 12:59:58 INFO - PROCESS | 15737 | |3;audio-fft;76;76;75;176;76;76;75;76;167;77 12:59:58 INFO - PROCESS | 15737 | |4;audio-oscillator;92;92;150;93;92;92;144;92;92;144 12:59:58 INFO - PROCESS | 15737 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;117;116;117 12:59:58 INFO - PROCESS | 15737 | |6;imaging-darkroom;144;145;144;144;145;145;145;145;145;145 12:59:58 INFO - PROCESS | 15737 | |7;imaging-desaturate;94;95;96;95;95;94;95;95;94;94 12:59:58 INFO - PROCESS | 15737 | |8;json-parse-financial;59;58;58;58;57;58;60;77;56;57 12:59:58 INFO - PROCESS | 15737 | |9;json-stringify-tinderbox;59;69;60;59;60;60;59;60;60;60 12:59:58 INFO - PROCESS | 15737 | |10;stanford-crypto-aes;71;78;71;72;72;73;72;72;73;80 12:59:58 INFO - PROCESS | 15737 | |11;stanford-crypto-ccm;115;116;117;114;113;112;122;111;127;126 12:59:58 INFO - PROCESS | 15737 | |12;stanford-crypto-pbkdf2;165;163;163;164;167;165;163;163;161;166 12:59:58 INFO - PROCESS | 15737 | |13;stanford-crypto-sha256-iterative;71;67;69;67;71;68;71;67;66;66 12:59:58 INFO - PROCESS | 15737 | __end_tp_report 12:59:58 INFO - PROCESS | 15737 | __start_cc_report 12:59:58 INFO - PROCESS | 15737 | _x_x_mozilla_cycle_collect,1597 12:59:58 INFO - PROCESS | 15737 | __end_cc_report 12:59:58 INFO - PROCESS | 15737 | __startTimestamp1469131198393__endTimestamp 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | ------- Summary: start ------- 12:59:58 INFO - PROCESS | 15737 | Number of tests: 14 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.06 (1.9%) stddev-sans-first:2.13 12:59:58 INFO - PROCESS | 15737 | Values: 112.0 112.0 112.0 111.0 111.0 111.0 105.0 111.0 111.0 111.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.00 stddev:21.15 (13.5%) stddev-sans-first:22.37 12:59:58 INFO - PROCESS | 15737 | Values: 155.0 126.0 159.0 183.0 136.0 153.0 163.0 127.0 177.0 125.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 12:59:58 INFO - PROCESS | 15737 | Values: 160.0 159.0 159.0 159.0 162.0 159.0 161.0 160.0 159.0 160.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.38 (53.1%) stddev-sans-first:42.24 12:59:58 INFO - PROCESS | 15737 | Values: 76.0 76.0 75.0 176.0 76.0 76.0 75.0 76.0 167.0 77.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.00 stddev:26.07 (28.3%) stddev-sans-first:26.97 12:59:58 INFO - PROCESS | 15737 | Values: 92.0 92.0 150.0 93.0 92.0 92.0 144.0 92.0 92.0 144.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 12:59:58 INFO - PROCESS | 15737 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 116.0 117.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#6] imaging-darkroom Cycles:10 Average:144.70 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 12:59:58 INFO - PROCESS | 15737 | Values: 144.0 145.0 144.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 12:59:58 INFO - PROCESS | 15737 | Values: 94.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.00 stddev:6.14 (10.6%) stddev-sans-first:6.51 12:59:58 INFO - PROCESS | 15737 | Values: 59.0 58.0 58.0 58.0 57.0 58.0 60.0 77.0 56.0 57.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:2.99 (5.0%) stddev-sans-first:3.11 12:59:58 INFO - PROCESS | 15737 | Values: 59.0 69.0 60.0 59.0 60.0 60.0 59.0 60.0 60.0 60.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:72.50 stddev:3.06 (4.2%) stddev-sans-first:3.12 12:59:58 INFO - PROCESS | 15737 | Values: 71.0 78.0 71.0 72.0 72.0 73.0 72.0 72.0 73.0 80.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:116.50 stddev:5.74 (4.9%) stddev-sans-first:6.02 12:59:58 INFO - PROCESS | 15737 | Values: 115.0 116.0 117.0 114.0 113.0 112.0 122.0 111.0 127.0 126.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.50 stddev:1.76 (1.1%) stddev-sans-first:1.83 12:59:58 INFO - PROCESS | 15737 | Values: 165.0 163.0 163.0 164.0 167.0 165.0 163.0 163.0 161.0 166.0 12:59:58 INFO - PROCESS | 15737 | 12:59:58 INFO - PROCESS | 15737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.06 (3.0%) stddev-sans-first:1.94 12:59:58 INFO - PROCESS | 15737 | Values: 71.0 67.0 69.0 67.0 71.0 68.0 71.0 67.0 66.0 66.0 12:59:58 INFO - PROCESS | 15737 | -------- Summary: end -------- 12:59:58 INFO - PROCESS | 15737 | 12:59:59 INFO - TEST-INFO | 15737: exit 0 12:59:59 INFO - TEST-OK | kraken | took 59445ms 12:59:59 INFO - SUITE-END | took 1170s 12:59:59 INFO - Completed test suite (00:19:30) 12:59:59 INFO - javascript benchmark 12:59:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.5724855768754, 3338.983305083475, 3357.9664203357975, 3392.7116195123413, 3397.9320413591727, 5585.357683866357, 5592.580556458267, 5596.58025648077, 5597.412271711468, 5598.300212473441, 5563.0, 5608.355039170497, 5611.242482264893, 5619.775208991636, 5651.943480565194, 4950.6287028472825, 4992.201247800353, 5167.819126330579, 5212.582993360522, 5241.5806735461265, 5062.468440813716, 5095.133827249377, 5131.050755610206, 5134.0, 5137.537621614054, 5065.290859279704, 5115.335006449156, 5123.385193776752, 5135.281060651511, 5147.768350424221, 5036.043151801146, 5036.899262014757, 5055.823046193365, 5060.822871199527, 5087.643864929438, 4899.58353539946, 4918.8278410255825, 4948.38145231846, 4949.950500494985, 4970.378702662168, 5316.5746740261075, 5368.248445217672, 5376.247325374451, 5384.542313903323, 5396.487333703292, 5904.055351143839, 5963.314218864843, 5963.671998040106, 5966.0454327307425, 5970.0, 5965.850853728692, 5990.371011043821, 6059.606125601866, 6063.211782468295, 6096.573239873211, 5618.578606604521, 5621.971890140564, 5637.548996080344, 5639.605227634108, 5650.858728531778, 5951.166836642873, 6150.661713605795, 6152.569320147547, 6155.938440615537, 6157.0, 5832.212651292106, 5918.437748413894, 5921.792737254175, 5935.317438494542, 5937.732802023919, 5892.764289428461, 5893.823185304448, 5895.705214739246, 5902.468777810018, 5906.49794767441, 5740.827775166752, 5831.183634291203, 5872.0898260769645, 5874.73563689635, 5879.559033072536, 5940.227770389908, 5959.493443057302, 5964.194833697482, 5970.820875373745, 6003.249593800775, 4540.409746732969, 4550.954490455119, 4551.95448045522, 4553.248713962159, 4579.290210017452, 4001.979990100031, 4002.539707933625, 4069.5116586009276, 4078.4494093297617, 4124.752514849119, 5710.857228569319, 5712.571557133231, 5728.1694154348215, 5731.512821410143, 5735.1970724098655, 5959.433853783884, 5995.61028533144, 6012.789552365646, 6014.609050411709, 6021.307549631849, 5526.889462210734, 5635.633683810539, 5701.629394089371, 5717.514011309002, 5739.971300143473, 5076.898462030738, 5078.644494885322, 5079.6698214615935, 5079.771410286546, 5099.719515426687, 6258.217722784652, 6263.561550691499, 6264.968675156595, 6266.091416744546, 6276.968615156895, 5789.044807606866, 5948.345681975065, 5989.281286245591, 6001.219841420588, 6031.09533569968, 6212.844678883064, 6235.657038862906, 6246.718897649707, 6249.750009999549, 6254.155688982111, 5878.470937615464, 5885.73514191871, 5886.38192989747, 5886.6173698709445, 5921.5558833086825, 5826.6504009757855, 5934.228550288435, 5988.161657367885, 6039.577229594062, 6043.395660433922, 5854.912176317273, 5863.120531920075, 5874.295084589877, 5879.617824841543, 5879.94120058811, 5787.9421205789085, 5834.591578589458, 5849.0, 5851.64890106578, 5855.180274761622, 5598.048331783688, 5710.200571920018, 5771.797987070432, 5781.277340332458, 5792.015357389169, 5816.069428891357, 5831.4168583141345, 5839.562032847469, 5869.35437101927, 5881.264841894763, 5642.294713160855, 5743.827685169452, 5747.683877386617, 5747.712614369349, 5772.134179873053], "value": 5505.1913083853315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.7957733102738, 668.4958842604141, 669.3139531979721, 677.0555075669445, 679.6601699150425, 31592.68407315929, 32209.67790322099, 41064.58935410645, 41738.7913060435, 41843.372349414705, 43171.35242971358, 43549.7822510887, 43585.78207108968, 43663.0, 43683.34474982878, 7735.690572377098, 8788.209061184492, 9045.095490450967, 9047.954760226223, 10383.221258405612, 10458.215633827454, 10598.894011059907, 10602.151827853753, 10604.363738175734, 10605.0, 10659.573617055308, 10753.139748820115, 10753.78492430151, 10755.677329680084, 10758.677239682784, 10568.577256909753, 10618.78762424751, 10630.149588032938, 10636.255462117655, 10641.467926603638, 10579.047885690248, 11000.0, 11003.449827508593, 11011.0, 11012.779744405147, 43801.0, 44307.0, 44348.77825610884, 44361.556384436386, 44416.3337549937, 3912.100216950089, 4063.817128229237, 4196.874093777192, 4209.621134097946, 4753.3582966299455, 31127.533087003714, 31315.0, 31413.214669633442, 31542.211444713837, 32521.51217731736, 4244.490661120685, 4378.6934914555995, 4431.180231657154, 4481.641468682497, 4619.8152073917, 210427.0, 211708.0, 211906.0, 212544.99999999846, 212579.0, 39381.0, 57624.0, 62756.686216568625, 63278.367216328166, 63378.049329260095, 38450.807745961094, 38519.614803852164, 38569.228615428096, 38596.61403385986, 38654.0, 15821.367145314289, 17111.0, 17284.567885802702, 17385.130743462778, 17387.65224695499, 14735.189564573837, 14930.925345373204, 15039.924800375928, 15053.623659408384, 15079.849201507845, 9318.161365477139, 9382.437053776659, 9384.90615093854, 9462.716118516455, 9481.573329200202, 3597.334493118781, 3684.6683798458266, 3707.0917625182, 3717.20080182762, 3755.5681096673684, 1126.3185772607455, 1136.710138914588, 1209.1596340543415, 1211.206639795094, 1301.811237370576, 33525.161870952936, 33793.0, 34092.31815363679, 34332.82833585816, 35538.822305888825, 1188.8335633011386, 1222.7676741419102, 1230.8584512781144, 1317.80232965056, 1331.9533816316382, 17777.46667599974, 18517.166727497024, 18757.624847503248, 18775.812241877407, 18831.90584047071, 480456.0, 484183.0, 484849.0, 485087.0, 485908.0, 63554.364456354844, 64023.67988160029, 64434.67782661057, 64439.67780161069, 64454.677726611066, 1361.1356788439412, 1491.7762335649738, 1500.4748338081583, 1501.054335768459, 1546.2500687166714, 30539.0, 30833.075007748907, 31652.208694781893, 32206.67793322037, 32679.673203267663, 50898.74550627223, 52405.0, 52410.0, 52422.47577524176, 52501.0, 301776.0, 303913.0, 304452.0, 304985.0, 306328.0, 27723.722762772115, 31427.528587070756, 49870.251946221564, 50274.24588631246, 50987.235191471416, 50530.49469505258, 50736.0, 50802.74598626983, 51098.74450627723, 51434.0, 43812.78093609639, 43874.0, 44375.334369985125, 44866.77566612146, 45672.0, 43733.34399984066, 44578.3313250295, 44607.55392446164, 45001.77499112614, 46978.53021469741, 45541.31688024748, 45810.31284530668, 46918.76540617275, 47147.292790607484, 47149.0, 39643.405348919216, 40409.39385909155, 40535.59464405436, 40613.79693101515, 41375.7931210342, 30259.243518912204, 30776.69223307738, 30940.53589196209, 30971.0, 31257.8437107813], "value": 20068.97353105547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.75619506393684, 411.2433123053581, 426.24129050290475, 436.5983295368261, 436.7423220300024, 14635.92682036591, 19000.14499347531, 19634.410967670956, 19651.410457686256, 20362.287319943804, 15075.321610527526, 19155.0, 19507.317243896465, 19927.501812454695, 20818.89590552049, 5559.972200139004, 5734.569907256951, 5748.080307150857, 5769.04810706233, 5774.018416869142, 5620.690862002588, 5688.544916406699, 5694.829155125353, 5695.174199741055, 5698.173764804101, 5587.0, 5653.886922261552, 5667.773289068432, 5673.12066629671, 5673.404292549285, 5620.606557540974, 5727.656340619535, 5762.3373312069225, 5781.39295373986, 5786.392428794979, 5143.614228932845, 5175.508326708957, 5182.792688292464, 5197.428282888879, 5230.953809238167, 23777.88111059451, 23937.64093538598, 24562.0, 24570.262892113264, 24687.62968555473, 2479.7024357077084, 2500.087468074158, 2826.6325377700973, 2855.0, 2925.0639795265524, 14522.273886305642, 15110.622234444118, 15204.0, 15262.31319590621, 15535.766963495556, 2042.5710600773855, 2078.262216912989, 2087.6242276390244, 2103.8842863642494, 2130.1585873579847, 77800.61099694522, 78391.60804195999, 79377.0, 79902.0, 80610.19389806085, 10831.0, 10931.453427328603, 11200.431939528473, 11231.326120432801, 11397.772044559062, 15451.072935623899, 15515.922420387826, 15559.29983150761, 15701.764473532907, 15711.371545138296, 8645.13548645143, 8731.519766412908, 8779.736607901774, 8797.0, 8798.164174403422, 8466.957665211758, 8471.534065626327, 8546.572671366406, 8613.48319100856, 8617.138286171332, 6210.72051757672, 6926.896096558556, 7029.3673569379, 7053.470989675795, 7103.538270012433, 1831.8134555205654, 1989.1365611080769, 1993.8205561499535, 1999.8700084494462, 2016.7882372350984, 1035.1977217656377, 1121.5233525751523, 1148.4602236948622, 1179.7050737315672, 1196.8683444821063, 19448.319308824408, 19616.0, 19781.802181978284, 19838.90080549588, 19972.600547988957, 1110.1285490889613, 1148.4831825678311, 1169.0939521870448, 1180.1620849196995, 1216.0271782574082, 11247.887521124683, 11338.886611133783, 11520.193586449035, 11543.826842597367, 11546.653600392001, 380662.0, 382465.0, 385627.0, 386251.0, 512400.0, 91283.54358228167, 98469.50765246128, 99514.0, 99741.50129249452, 99754.5012274934, 1130.0846314485293, 1145.3498794892596, 1146.4267866066966, 1150.896419322265, 1163.0637336943842, 17301.62218315495, 17750.023748693944, 17755.733663994793, 17802.37691680785, 18254.72617910759, 40026.799866001646, 40079.99800005023, 40379.798101010485, 40719.389209161294, 41138.38292425556, 57518.0, 59419.70290148695, 59875.700621498356, 60012.69993650004, 60074.0, 8663.783405414915, 8834.381593288408, 8836.469811811312, 8938.329625278, 8961.014288428398, 9281.814363712552, 12781.744365112832, 13185.340732963505, 13476.124051936593, 13541.052126351455, 11577.247478913843, 11614.419279035845, 11715.355655439032, 12145.0, 12150.939245303716, 11483.138764592522, 11546.94226528862, 11721.824172637587, 11727.882721172678, 11937.164398492023, 11861.881381186422, 11972.401379930794, 12125.575604853788, 12312.50749970027, 12390.75218495607, 8563.61463734146, 8570.100139485265, 8616.612252448529, 8622.525761083201, 8927.642894284416, 11402.771944560896, 11987.100967427303, 12007.39963001829, 12014.459349329127, 12118.151729378858], "value": 9637.721098773258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.5780087073438, 1542.9382824687013, 1556.3307777655607, 1742.9912850435746, 1898.079431475734, 7142.25006374331, 7978.6808527658895, 8119.959400203005, 8137.755867323975, 8159.22487363701, 8065.879011814813, 8070.354371650268, 8135.145809689986, 8141.307988820958, 8170.223828736261, 2354.0701422937886, 2375.192434572245, 2376.310869847742, 2377.1561095811, 2377.3224630980176, 2367.739548649647, 2386.6181410974245, 2414.263649586875, 2416.4079800448912, 2422.6002709552904, 2386.725526564441, 2411.4212588978694, 2413.5776239158163, 2426.9271921842374, 2445.5231229910173, 2367.739548649647, 2376.5246950609862, 2378.916737914173, 2381.4641705616273, 2442.7312995570474, 2374.4776149247136, 2391.485830546441, 2399.6280576510667, 2404.326788499223, 2405.9518809623883, 7994.480358776661, 8308.252257296872, 8342.499450033018, 8345.207205315486, 8350.331973442171, 5187.688738675653, 5252.71110088945, 5259.368875734898, 5301.946980530184, 5305.814296499604, 3433.53647257622, 3489.45913383426, 3512.2799826035603, 3620.5836328821997, 3631.8365673544754, 1191.48170545812, 1196.497471062156, 1202.140469564257, 1227.9938600306941, 1246.9688257793537, 11200.719982000433, 11304.37825919574, 11544.30734155945, 11646.068314534818, 11650.70873228176, 4414.404055452473, 4560.429946256718, 4566.70316429431, 4585.312203169551, 4588.587027167571, 9355.204807591295, 9390.248780097576, 9409.76475588102, 9414.811703766023, 9418.152366287068, 5239.345081864767, 5275.788968441219, 5285.524302812765, 5289.894202115936, 5296.947030529645, 4125.339945608748, 4272.380504826782, 4704.03567268716, 4730.077634861169, 4891.315215869781, 3794.2411517696573, 3811.7331786774657, 3862.5364956205435, 3880.3209438348176, 3920.666743326792, 1144.9026832719146, 1146.529922731676, 1148.6726283009302, 1148.7765529710832, 1173.4836671864352, 1032.7573020340214, 1050.0444595418285, 1050.1703654113317, 1067.8344856547092, 1073.75303680154, 5859.267591551056, 5990.700464976734, 6055.5458340623745, 6112.663803490851, 6157.4458298753325, 475.08546048855817, 479.144726662912, 483.58170182791633, 488.39682991505464, 490.05174986401425, 3845.0, 3872.8063596820048, 4033.596640335943, 4092.6112019358116, 4119.0, 10141.087302142843, 10339.121174700234, 10435.217358698128, 10479.42363170033, 10490.265681402381, 10239.539220735085, 10291.53688084038, 10301.124404425558, 10303.072723454925, 10313.587456501657, 7711.344535714415, 7727.150013498511, 7783.805404864924, 7806.219378062148, 7807.6486558105025, 5695.145728140812, 5710.086386178192, 5837.5038121758425, 5896.351401345934, 5904.409559044061, 8805.075467076122, 8863.64545418176, 8994.640214391613, 8997.100289970951, 9016.81966360656, 8859.60131794058, 8903.421277616933, 9066.410683305565, 9084.454932704059, 9092.227160691415, 6644.4020038196795, 6841.8973715395305, 7284.635768211674, 7608.201138880338, 7738.729144479917, 8012.799680008046, 8040.276375126266, 8042.356611471186, 8052.87920681202, 8074.87887681697, 7180.0, 7275.818104547428, 7323.340899319087, 7390.5196162249285, 7479.813004674927, 7022.403095736715, 7025.192102908027, 7083.610401427764, 7096.077509923884, 7121.608311542915, 6931.584104953719, 6987.441004719712, 6988.301169882971, 6996.0, 7002.0, 4865.7323847188745, 5027.170516864677, 5039.84880453587, 5045.066662667418, 5111.258867464123, 5204.0892843752945, 5240.2663627093, 5256.553192978639, 5397.109476936262, 5410.48600382963], "value": 4446.834753361915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.69709912529163, 337.7585026705905, 350.8299820099966, 363.0904584017037, 363.23357715220897, 6143.354947730491, 6154.169187159732, 6201.441870231678, 6202.875942481148, 6216.347283535231, 5794.420557944203, 5912.260967379078, 5993.46058854703, 6056.454919057284, 6105.725242364093, 4710.081534100852, 4727.858164255078, 4748.548887855648, 4764.332993380929, 4775.092732380854, 4767.666263361566, 4771.165046116916, 4774.427068751755, 4788.952110478903, 4793.5925446337105, 4522.751248681321, 4606.239970404879, 4708.246680531116, 4719.0, 4724.1260366832075, 4690.788914498856, 4697.224957881946, 4712.410948631421, 4714.90570188596, 4719.221328480797, 4158.022864626811, 4162.125953549758, 4166.375043743433, 4168.24971505129, 4170.895727606804, 5884.823455296348, 5888.499477544414, 5890.676012819294, 5891.528677705774, 5892.175095486592, 5430.67415955044, 5438.749087709809, 5445.101558242885, 5445.727713614343, 5445.754941027663, 6158.199434073542, 6366.586171898812, 6376.872462550723, 6435.517336199804, 6444.838879028015, 4471.955280447187, 4496.123255965088, 4496.730196188207, 4509.503954564995, 4515.887102822423, 6655.567388119756, 6688.498362622774, 6719.126513553256, 6719.160104986877, 6721.327867213288, 4573.679842411066, 4605.6085232755595, 4609.907801843944, 4613.561711637389, 4615.561521655437, 4659.697119687209, 4669.60308373792, 4670.252759558454, 4672.112298663243, 4672.135654903854, 5248.396434410015, 5318.175682769177, 5362.946370536322, 5367.75845086972, 5384.300040994645, 6452.774152904626, 6474.902876456857, 6478.255000674889, 6479.125318082093, 6491.772787952494, 1533.0571698405624, 1591.8885678002428, 1616.6605012947177, 1634.1012443156453, 1635.852773250413, 1060.7825395793843, 1076.6070384309671, 1077.946102694862, 1083.090204228452, 1085.6580177244143, 6185.350538193515, 6260.40526150015, 6260.561760676709, 6266.530010249158, 6272.3100458949475, 6591.143151390384, 6601.735930562723, 6605.966970165118, 6606.8348291293105, 6611.900821487681, 6240.625562466266, 6253.405926436982, 6255.155554000243, 6259.217597800275, 6260.186175797117, 3543.4684797280615, 3558.377283975294, 3562.7684200526883, 3563.518924945099, 3569.339672160607, 6788.558743681645, 6940.0, 6943.097397338414, 6951.826204344932, 6955.965220173968, 6631.734730610721, 6676.065350850885, 6679.332066793282, 6680.198376194888, 6692.263850976388, 6916.654167291716, 6922.653867306614, 6929.5842249465195, 6936.34104760047, 6936.994135850375, 6586.736530538917, 6590.736370545316, 6591.835204119743, 6592.406683398517, 6594.274629790815, 6332.145160403471, 6493.967530162319, 6495.772647957298, 6504.414602685781, 6568.7372505099265, 6891.27641597625, 6918.515703900679, 6918.619475928671, 6925.792226233221, 6941.965290173517, 4577.084583083463, 4579.816807327803, 4583.54164583539, 4591.609713174284, 4592.908141837078, 6383.904241436289, 6582.80251592453, 6585.111010013587, 6589.670516474253, 6590.703418346282, 6356.078368636614, 6526.836829079121, 6539.11721917535, 6540.215174179129, 6546.345365463416, 6503.934960650333, 6521.836954076186, 6528.477721782341, 6536.934630653823, 6541.771038013647, 6426.550141490051, 6430.099786030053, 6430.389113034442, 6431.324710905287, 6435.356464353715, 6459.515536334699, 6572.079908812674, 6584.374484423972, 6591.209054913249, 6593.340665933369, 6385.776497822554, 6390.392912673288, 6393.392627700361, 6393.744250230125, 6393.904091438539], "value": 4884.853838280686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.924046835785, 859.4886042804533, 861.7285555050163, 902.318749344245, 926.0554234680624, 14134.0812847165, 15141.16723580204, 15382.230888455575, 16878.0, 17621.823781762178, 15243.31405086771, 15297.770533441979, 15360.692786144298, 15386.846131538681, 15392.076475411455, 730.8355619985488, 913.4610579757925, 917.9311551633621, 923.5705396990398, 944.9574769135405, 921.8386782313102, 924.3714274293478, 926.5784068248964, 929.8233335666235, 930.418488444722, 977.252401912534, 985.960561577536, 986.5856340337076, 987.2250283527433, 987.4026214140414, 748.4685873030155, 950.5959967014061, 981.8379967305386, 984.807962447323, 986.1519093579516, 713.4292565947221, 714.8748968930416, 715.3597530210433, 715.4348065028621, 715.5456285258846, 15702.293396797057, 15776.526704198892, 15777.0, 15799.763003554956, 15812.13033283169, 14551.854481455155, 14730.852691473056, 14782.0, 14843.703125937422, 15010.849891501055, 11857.110716696283, 11895.702607434883, 12111.697207569792, 12123.515059397614, 12263.816042759276, 4073.2668119738437, 4075.9592404075875, 4092.5907409259135, 4121.52602450716, 4180.686448516373, 55040.0, 55100.448995509934, 55213.72393138049, 55239.447605524234, 55659.0, 11303.265287756269, 11340.262882912584, 11344.205905586694, 11702.473388697528, 11751.764964700658, 20140.496487587927, 20145.194192232146, 20185.59628807445, 20197.596048078954, 20198.192072316942, 8459.154084591491, 8472.068072512018, 8542.18849209324, 8658.437201581877, 8755.387122901337, 4907.2393778964315, 4915.3855768029, 4919.163742163841, 4944.653874228769, 5216.817411390659, 3789.317922773872, 3848.0956975110826, 3849.557300910375, 3849.826757795906, 3855.749376290532, 687.8933765266391, 689.1248114894056, 689.19020151323, 705.5096707788141, 726.3136336162275, 839.4669384940606, 869.799946012408, 871.1201686296886, 874.2437791310598, 877.6006916852816, 9446.38598491096, 9467.952660236655, 9511.0, 9596.0, 9701.126898579161, 830.7923019245188, 837.5058715357968, 843.2705709561185, 858.4763294390417, 866.1771317248639, 4723.7638118093955, 4742.905141897143, 4813.446453657804, 4844.32179494871, 4956.479569645207, 59856.40143598595, 59974.70012649996, 60203.69898150569, 60354.396456035756, 67789.32210677929, 52971.47028529742, 53053.0, 53468.0, 54345.0, 54426.0, 52524.737376313635, 52928.73535632297, 53081.0, 53270.467295327326, 53702.0, 10004.749881253027, 10024.548895299584, 10038.347507411994, 10190.1338386238, 10266.743331416774, 36821.26357472889, 38111.0, 38246.42630360491, 39333.80333098316, 39602.60397395989, 44595.331070033324, 48144.51855481401, 51555.22667159921, 51943.22085168801, 53132.734336328074, 11617.244879082833, 12034.277943323428, 12293.0, 12722.745545089232, 12826.102172847812, 12464.314462704275, 13692.041557091306, 14526.564203073925, 14852.480163194236, 15056.548303550911, 12957.0, 13872.375743091383, 13955.37200825945, 14129.646758831112, 14145.0, 13348.866511334762, 13687.726245475234, 13816.516421925184, 13846.861531384557, 14190.57428277112, 13499.730005400033, 13613.387397566936, 13707.725845482835, 13910.443582256596, 13968.441262349392, 11279.32324060559, 11399.658010259705, 11620.925817321564, 11621.302721836379, 11880.643580692593, 11237.3257604544, 11479.024282936043, 11565.537378505102, 12355.135140540076, 12423.192492487959], "value": 7330.521924242398, "unit": "score"}], "name": "dromaeo_css", "value": 7439.751383091303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 105.0, 111.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 159.0, 183.0, 136.0, 153.0, 163.0, 127.0, 177.0, 125.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 159.0, 162.0, 159.0, 161.0, 160.0, 159.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 176.0, 76.0, 76.0, 75.0, 76.0, 167.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 93.0, 92.0, 92.0, 144.0, 92.0, 92.0, 144.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 116.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 144.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 144.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 57.0, 58.0, 60.0, 77.0, 56.0, 57.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 69.0, 60.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 78.0, 71.0, 72.0, 72.0, 73.0, 72.0, 72.0, 73.0, 80.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 117.0, 114.0, 113.0, 112.0, 122.0, 111.0, 127.0, 126.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 164.0, 167.0, 165.0, 163.0, 163.0, 161.0, 166.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 69.0, 67.0, 71.0, 68.0, 71.0, 67.0, 66.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1524.3999999999999, "alertThreshold": 2.0}]} 12:59:59 INFO - Return code: 0 12:59:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:59:59 ERROR - # TBPL SUCCESS # 12:59:59 INFO - Running post-action listener: _resource_record_post_action 12:59:59 INFO - Running post-run listener: _resource_record_post_run 13:00:00 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 28672; Write bytes: 468869120; Read time: 28; Write time: 434284 13:00:00 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242266112; Read time: 0; Write time: 278616 13:00:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222306304; Read time: 16; Write time: 148396 13:00:00 INFO - Running post-run listener: _upload_blobber_files 13:00:00 INFO - Blob upload gear active. 13:00:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00:00 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 13:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:00:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:00:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:02 INFO - (blobuploader) - INFO - Done attempting. 13:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:03 INFO - (blobuploader) - INFO - Done attempting. 13:00:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:03 INFO - Return code: 0 13:00:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:00:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0535b1ad5a67328f3eb603c49ae0711a393e9d90ce21cfa54571f3bbcc9ac38702b739808c4df04d25f7f341be88be2d29a8487f9fafa3cb3e88edaf17b2fe00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1424874ea4eab79f1f57017f2bb9b2cb249d0b4be9864321f5875f2021e0b00d49c1a233cf9436c82006d2d606f409e384bc38f8f943a60b51082354b4db3aca"} 13:00:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:00:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:00:03 INFO - Contents: 13:00:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0535b1ad5a67328f3eb603c49ae0711a393e9d90ce21cfa54571f3bbcc9ac38702b739808c4df04d25f7f341be88be2d29a8487f9fafa3cb3e88edaf17b2fe00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1424874ea4eab79f1f57017f2bb9b2cb249d0b4be9864321f5875f2021e0b00d49c1a233cf9436c82006d2d606f409e384bc38f8f943a60b51082354b4db3aca"} 13:00:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:00:03 INFO - Copying logs to upload dir... 13:00:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:00:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.908834 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-21 13:00:02.973859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 13:00:02.981983) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0535b1ad5a67328f3eb603c49ae0711a393e9d90ce21cfa54571f3bbcc9ac38702b739808c4df04d25f7f341be88be2d29a8487f9fafa3cb3e88edaf17b2fe00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1424874ea4eab79f1f57017f2bb9b2cb249d0b4be9864321f5875f2021e0b00d49c1a233cf9436c82006d2d606f409e384bc38f8f943a60b51082354b4db3aca"} build_url:https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/Lhp0G1-bRg-6XveIwZywHw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0535b1ad5a67328f3eb603c49ae0711a393e9d90ce21cfa54571f3bbcc9ac38702b739808c4df04d25f7f341be88be2d29a8487f9fafa3cb3e88edaf17b2fe00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1424874ea4eab79f1f57017f2bb9b2cb249d0b4be9864321f5875f2021e0b00d49c1a233cf9436c82006d2d606f409e384bc38f8f943a60b51082354b4db3aca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 13:00:03.017767) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:00:03.018277) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469129977.66056-1811253899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:00:03.097132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 13:00:03.099529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 13:00:03.099874) ========= ========= Total master_lag: 0.20 =========