builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1469553418.26 results: success (0) buildid: 20160726073608 builduid: d1cb8ed0c7bb4f2f81757e781ad3dd8a revision: 2a0c3fd014516cd8718395e25a8cecd1fa29e0cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.257840) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.258302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.258656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.274215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.274838) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 10:16:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-26 10:16:59 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.366500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.366840) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.416535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:58.416895) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2a0c3fd014516cd8718395e25a8cecd1fa29e0cb --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-aurora --rev 2a0c3fd014516cd8718395e25a8cecd1fa29e0cb --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=3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 10:16:59,342 truncating revision to first 12 chars 2016-07-26 10:16:59,342 Setting DEBUG logging. 2016-07-26 10:16:59,342 attempt 1/10 2016-07-26 10:16:59,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2a0c3fd01451?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 10:16:59,654 unpacking tar archive at: mozilla-aurora-2a0c3fd01451/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:59.076099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:59.076460) ========= script_repo_revision: 2a0c3fd014516cd8718395e25a8cecd1fa29e0cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:59.076985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:59.077269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 10:16:59.088975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-26 10:16:59.089461) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:17:00 INFO - MultiFileLogger online at 20160726 10:17:00 in /builds/slave/test 10:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:17:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:00 INFO - {'append_to_log': False, 10:17:00 INFO - 'base_work_dir': '/builds/slave/test', 10:17:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:17:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:00 INFO - 'branch': 'Mozilla-Aurora', 10:17:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:00 INFO - 'config_files': ('talos/linux_config.py',), 10:17:00 INFO - 'default_actions': ('clobber', 10:17:00 INFO - 'read-buildbot-config', 10:17:00 INFO - 'download-and-extract', 10:17:00 INFO - 'populate-webroot', 10:17:00 INFO - 'create-virtualenv', 10:17:00 INFO - 'install', 10:17:00 INFO - 'run-tests'), 10:17:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:00 INFO - 'download_minidump_stackwalk': True, 10:17:00 INFO - 'download_symbols': 'ondemand', 10:17:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:00 INFO - 'installer_path': 'installer.exe', 10:17:00 INFO - 'log_level': 'info', 10:17:00 INFO - 'log_name': 'talos', 10:17:00 INFO - 'log_to_console': True, 10:17:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:17:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:17:00 INFO - 'opt_config_files': (), 10:17:00 INFO - 'pip_index': False, 10:17:00 INFO - 'sps_profile': False, 10:17:00 INFO - 'sps_profile_interval': 0, 10:17:00 INFO - 'suite': 'dromaeojs', 10:17:00 INFO - 'system_bits': '32', 10:17:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:00 INFO - 'title': 'talos-linux64-ix-059', 10:17:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:00 INFO - 'use_talos_json': True, 10:17:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:00 INFO - 'work_dir': 'build'} 10:17:00 INFO - ##### 10:17:00 INFO - ##### Running clobber step. 10:17:00 INFO - ##### 10:17:00 INFO - Running pre-action listener: _resource_record_pre_action 10:17:00 INFO - Running main action method: clobber 10:17:00 INFO - rmtree: /builds/slave/test/build 10:17:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:01 INFO - Running post-action listener: _resource_record_post_action 10:17:01 INFO - ##### 10:17:01 INFO - ##### Finished clobber step (success) 10:17:01 INFO - ##### 10:17:01 INFO - ##### 10:17:01 INFO - ##### Running read-buildbot-config step. 10:17:01 INFO - ##### 10:17:01 INFO - Running pre-action listener: _resource_record_pre_action 10:17:01 INFO - Running main action method: read_buildbot_config 10:17:01 INFO - Using buildbot properties: 10:17:01 INFO - { 10:17:01 INFO - "project": "", 10:17:01 INFO - "product": "firefox", 10:17:01 INFO - "script_repo_revision": "production", 10:17:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:17:01 INFO - "repository": "", 10:17:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:17:01 INFO - "buildid": "20160726073608", 10:17:01 INFO - "pgo_build": "True", 10:17:01 INFO - "basedir": "/builds/slave/test", 10:17:01 INFO - "buildnumber": 631, 10:17:01 INFO - "slavename": "talos-linux64-ix-059", 10:17:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:17:01 INFO - "platform": "ubuntu64_hw", 10:17:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:17:01 INFO - "branch": "mozilla-aurora", 10:17:01 INFO - "repo_path": "releases/mozilla-aurora", 10:17:01 INFO - "revision": "2a0c3fd014516cd8718395e25a8cecd1fa29e0cb", 10:17:01 INFO - "stage_platform": "linux64-pgo", 10:17:01 INFO - "builduid": "d1cb8ed0c7bb4f2f81757e781ad3dd8a", 10:17:01 INFO - "slavebuilddir": "test" 10:17:01 INFO - } 10:17:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:17:01 INFO - Running post-action listener: _resource_record_post_action 10:17:01 INFO - ##### 10:17:01 INFO - ##### Finished read-buildbot-config step (success) 10:17:01 INFO - ##### 10:17:01 INFO - ##### 10:17:01 INFO - ##### Running download-and-extract step. 10:17:01 INFO - ##### 10:17:01 INFO - Running pre-action listener: _resource_record_pre_action 10:17:01 INFO - Running main action method: download_and_extract 10:17:01 INFO - mkdir: /builds/slave/test/build/tests 10:17: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')]} 10:17:01 INFO - https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:17:02 INFO - Downloaded 1361 bytes. 10:17:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:17:02 INFO - Using the following test package requirements: 10:17:02 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:17:02 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:17:02 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:17:02 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'jsshell-linux-x86_64.zip'], 10:17:02 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:17:02 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:17:02 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:17:02 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:17:02 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:17:02 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:17:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:17:02 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:02 INFO - https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:17:04 INFO - Downloaded 24494547 bytes. 10:17:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:17:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:17:05 INFO - Return code: 0 10:17:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:05 INFO - https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:17:14 INFO - Downloaded 24494547 bytes. 10:17:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:17:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:17:16 INFO - Return code: 0 10:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:16 INFO - https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:17:17 INFO - Downloaded 10833369 bytes. 10:17:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:17:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:17:17 INFO - Return code: 0 10:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:17 INFO - https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:17:18 INFO - Downloaded 63640614 bytes. 10:17:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:17:18 INFO - mkdir: /builds/slave/test/properties 10:17:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:18 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:18 INFO - Contents: 10:17:18 INFO - build_url:https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:17:19 INFO - Running post-action listener: _resource_record_post_action 10:17:19 INFO - Running post-action listener: set_extra_try_arguments 10:17:19 INFO - ##### 10:17:19 INFO - ##### Finished download-and-extract step (success) 10:17:19 INFO - ##### 10:17:19 INFO - ##### 10:17:19 INFO - ##### Running populate-webroot step. 10:17:19 INFO - ##### 10:17:19 INFO - Running pre-action listener: _resource_record_pre_action 10:17:19 INFO - Running main action method: populate_webroot 10:17:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:19 INFO - '--tppagecycles', 10:17:19 INFO - '7'], 10:17:19 INFO - 'tests': ['tsvgm']}}, 10:17:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:17:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:17:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:17:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['damp', 'tps']}, 10:17:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'tests': ['damp', 'tps']}, 10:17:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['dromaeo_dom']}, 10:17:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['a11yr', 10:17:19 INFO - 'ts_paint', 10:17:19 INFO - 'tpaint', 10:17:19 INFO - 'sessionrestore', 10:17:19 INFO - 'sessionrestore_no_auto_restore', 10:17:19 INFO - 'tabpaint']}, 10:17:19 INFO - 'other-e10s': {'tests': ['a11yr', 10:17:19 INFO - 'ts_paint', 10:17:19 INFO - 'tpaint', 10:17:19 INFO - 'sessionrestore', 10:17:19 INFO - 'sessionrestore_no_auto_restore', 10:17:19 INFO - 'tabpaint']}, 10:17:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:17:19 INFO - 'ts_paint', 10:17:19 INFO - 'tpaint', 10:17:19 INFO - 'sessionrestore', 10:17:19 INFO - 'sessionrestore_no_auto_restore', 10:17:19 INFO - 'tabpaint']}, 10:17:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:17:19 INFO - 'ts_paint', 10:17:19 INFO - 'tpaint', 10:17:19 INFO - 'sessionrestore', 10:17:19 INFO - 'sessionrestore_no_auto_restore', 10:17:19 INFO - 'tabpaint']}, 10:17:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['a11yr', 10:17:19 INFO - 'ts_paint', 10:17:19 INFO - 'tpaint', 10:17:19 INFO - 'sessionrestore', 10:17:19 INFO - 'sessionrestore_no_auto_restore', 10:17:19 INFO - 'tabpaint']}, 10:17:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['a11yr', 10:17:19 INFO - 'ts_paint', 10:17:19 INFO - 'tpaint', 10:17:19 INFO - 'sessionrestore', 10:17:19 INFO - 'sessionrestore_no_auto_restore', 10:17:19 INFO - 'tabpaint']}, 10:17:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['tsvgx', 10:17:19 INFO - 'tsvgr_opacity', 10:17:19 INFO - 'tart', 10:17:19 INFO - 'tscrollx', 10:17:19 INFO - 'cart']}, 10:17:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:17:19 INFO - 'tsvgr_opacity', 10:17:19 INFO - 'tart', 10:17:19 INFO - 'tscrollx', 10:17:19 INFO - 'cart']}, 10:17:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'talos_options': ['--disable-e10s'], 10:17:19 INFO - 'tests': ['tp5o']}, 10:17:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'tests': ['tp5o']}, 10:17:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'talos_options': ['--disable-e10s', 10:17:19 INFO - '--xperf_path', 10:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:19 INFO - 'tests': ['tp5n']}, 10:17:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:19 INFO - 'talos_options': ['--xperf_path', 10:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:19 INFO - 'tests': ['tp5n']}}, 10:17:19 INFO - 'talos.zip': {'path': '', 10:17:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:19 INFO - Running post-action listener: _resource_record_post_action 10:17:19 INFO - ##### 10:17:19 INFO - ##### Finished populate-webroot step (success) 10:17:19 INFO - ##### 10:17:19 INFO - ##### 10:17:19 INFO - ##### Running create-virtualenv step. 10:17:19 INFO - ##### 10:17:19 INFO - Running pre-action listener: _resource_record_pre_action 10:17:19 INFO - Running main action method: create_virtualenv 10:17:19 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:19 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 10:17:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:19 INFO - Using real prefix '/usr' 10:17:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:20 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:22 INFO - Installing pip.................done. 10:17:22 INFO - Return code: 0 10:17:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:22 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 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:22 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 10:17:22 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 10:17:22 INFO - Using env: {'DISPLAY': ':0', 10:17:22 INFO - 'HOME': '/home/cltbld', 10:17:22 INFO - 'LANG': 'en_US.UTF-8', 10:17:22 INFO - 'LANGUAGE': 'en_US:en', 10:17:22 INFO - 'LOGNAME': 'cltbld', 10:17:22 INFO - 'MAIL': '/var/mail/cltbld', 10:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:22 INFO - 'MOZ_NO_REMOTE': '1', 10:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:22 INFO - 'NO_EM_RESTART': '1', 10:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:22 INFO - 'PWD': '/builds/slave/test', 10:17:22 INFO - 'SHELL': '/bin/bash', 10:17:22 INFO - 'SHLVL': '1', 10:17:22 INFO - 'TERM': 'linux', 10:17:22 INFO - 'TMOUT': '86400', 10:17:22 INFO - 'USER': 'cltbld', 10:17:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:22 INFO - '_': '/tools/buildbot/bin/python'} 10:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:22 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 10:17:22 INFO - Cleaning up... 10:17:22 INFO - Return code: 0 10:17:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:22 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:22 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>=3.1.1'] in /builds/slave/test/build 10:17:22 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>=3.1.1 10:17:22 INFO - Using env: {'DISPLAY': ':0', 10:17:22 INFO - 'HOME': '/home/cltbld', 10:17:22 INFO - 'LANG': 'en_US.UTF-8', 10:17:22 INFO - 'LANGUAGE': 'en_US:en', 10:17:22 INFO - 'LOGNAME': 'cltbld', 10:17:22 INFO - 'MAIL': '/var/mail/cltbld', 10:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:22 INFO - 'MOZ_NO_REMOTE': '1', 10:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:22 INFO - 'NO_EM_RESTART': '1', 10:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:22 INFO - 'PWD': '/builds/slave/test', 10:17:22 INFO - 'SHELL': '/bin/bash', 10:17:22 INFO - 'SHLVL': '1', 10:17:22 INFO - 'TERM': 'linux', 10:17:22 INFO - 'TMOUT': '86400', 10:17:22 INFO - 'USER': 'cltbld', 10:17:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:22 INFO - '_': '/tools/buildbot/bin/python'} 10:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:22 INFO - Downloading/unpacking psutil>=3.1.1 10:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:24 INFO - Installing collected packages: psutil 10:17:24 INFO - Running setup.py install for psutil 10:17:24 INFO - building 'psutil._psutil_linux' extension 10:17:24 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 10:17:24 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 10:17:25 INFO - building 'psutil._psutil_posix' extension 10:17:25 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 10:17:25 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 10:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:25 INFO - Successfully installed psutil 10:17:25 INFO - Cleaning up... 10:17:25 INFO - Return code: 0 10:17:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:25 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:25 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.3'] in /builds/slave/test/build 10:17:25 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.3 10:17:25 INFO - Using env: {'DISPLAY': ':0', 10:17:25 INFO - 'HOME': '/home/cltbld', 10:17:25 INFO - 'LANG': 'en_US.UTF-8', 10:17:25 INFO - 'LANGUAGE': 'en_US:en', 10:17:25 INFO - 'LOGNAME': 'cltbld', 10:17:25 INFO - 'MAIL': '/var/mail/cltbld', 10:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:25 INFO - 'MOZ_NO_REMOTE': '1', 10:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:25 INFO - 'NO_EM_RESTART': '1', 10:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:25 INFO - 'PWD': '/builds/slave/test', 10:17:25 INFO - 'SHELL': '/bin/bash', 10:17:25 INFO - 'SHLVL': '1', 10:17:25 INFO - 'TERM': 'linux', 10:17:25 INFO - 'TMOUT': '86400', 10:17:25 INFO - 'USER': 'cltbld', 10:17:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:25 INFO - '_': '/tools/buildbot/bin/python'} 10:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:17:27 INFO - Installing collected packages: mozsystemmonitor 10:17:27 INFO - Running setup.py install for mozsystemmonitor 10:17:27 INFO - Successfully installed mozsystemmonitor 10:17:27 INFO - Cleaning up... 10:17:27 INFO - Return code: 0 10:17:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:27 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:27 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==2.5.1'] in /builds/slave/test/build 10:17:27 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==2.5.1 10:17:27 INFO - Using env: {'DISPLAY': ':0', 10:17:27 INFO - 'HOME': '/home/cltbld', 10:17:27 INFO - 'LANG': 'en_US.UTF-8', 10:17:27 INFO - 'LANGUAGE': 'en_US:en', 10:17:27 INFO - 'LOGNAME': 'cltbld', 10:17:27 INFO - 'MAIL': '/var/mail/cltbld', 10:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:27 INFO - 'MOZ_NO_REMOTE': '1', 10:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:27 INFO - 'NO_EM_RESTART': '1', 10:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:27 INFO - 'PWD': '/builds/slave/test', 10:17:27 INFO - 'SHELL': '/bin/bash', 10:17:27 INFO - 'SHLVL': '1', 10:17:27 INFO - 'TERM': 'linux', 10:17:27 INFO - 'TMOUT': '86400', 10:17:27 INFO - 'USER': 'cltbld', 10:17:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:27 INFO - '_': '/tools/buildbot/bin/python'} 10:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:27 INFO - Downloading/unpacking jsonschema==2.5.1 10:17:27 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 10:17:27 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 10:17:27 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 10:17:27 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 10:17:27 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 10:17:27 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 10:17:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:17:29 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 10:17:29 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 10:17:29 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 10:17:29 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 10:17:29 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 10:17:29 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 10:17:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:30 INFO - warning: no files found matching '*.txt' 10:17:30 INFO - no previously-included directories found matching 'build' 10:17:30 INFO - no previously-included directories found matching 'dist' 10:17:30 INFO - no previously-included directories found matching '.git*' 10:17:30 INFO - Installing collected packages: jsonschema, functools32 10:17:30 INFO - Running setup.py install for functools32 10:17:30 INFO - warning: no files found matching '*.txt' 10:17:30 INFO - no previously-included directories found matching 'build' 10:17:30 INFO - no previously-included directories found matching 'dist' 10:17:30 INFO - no previously-included directories found matching '.git*' 10:17:30 INFO - Successfully installed jsonschema functools32 10:17:30 INFO - Cleaning up... 10:17:30 INFO - Return code: 0 10:17:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17:30 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')]} 10:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:30 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')]} 10:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:30 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 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:30 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 10:17:30 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 10:17:30 INFO - Using env: {'DISPLAY': ':0', 10:17:30 INFO - 'HOME': '/home/cltbld', 10:17:30 INFO - 'LANG': 'en_US.UTF-8', 10:17:30 INFO - 'LANGUAGE': 'en_US:en', 10:17:30 INFO - 'LOGNAME': 'cltbld', 10:17:30 INFO - 'MAIL': '/var/mail/cltbld', 10:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:30 INFO - 'MOZ_NO_REMOTE': '1', 10:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:30 INFO - 'NO_EM_RESTART': '1', 10:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:30 INFO - 'PWD': '/builds/slave/test', 10:17:30 INFO - 'SHELL': '/bin/bash', 10:17:30 INFO - 'SHLVL': '1', 10:17:30 INFO - 'TERM': 'linux', 10:17:30 INFO - 'TMOUT': '86400', 10:17:30 INFO - 'USER': 'cltbld', 10:17:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:30 INFO - '_': '/tools/buildbot/bin/python'} 10:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:30 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:30 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 10:17:30 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 10:17:30 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 10:17:30 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 10:17:30 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 10:17:30 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 10:17:32 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17:32 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 10:17:32 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 10:17:32 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 10:17:32 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 10:17:32 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 10:17:32 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 10:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:33 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 10:17:33 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 10:17:33 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 10:17:33 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 10:17:33 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 10:17:33 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 10:17:33 INFO - Downloading docopt-0.6.1.tar.gz 10:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:33 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:33 INFO - Running setup.py install for blobuploader 10:17:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:33 INFO - Running setup.py install for requests 10:17:33 INFO - Running setup.py install for docopt 10:17:33 INFO - Successfully installed blobuploader requests docopt 10:17:33 INFO - Cleaning up... 10:17:33 INFO - Return code: 0 10:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:33 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')]} 10:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:33 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')]} 10:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:33 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 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:33 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 10:17:33 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 10:17:33 INFO - Using env: {'DISPLAY': ':0', 10:17:33 INFO - 'HOME': '/home/cltbld', 10:17:33 INFO - 'LANG': 'en_US.UTF-8', 10:17:33 INFO - 'LANGUAGE': 'en_US:en', 10:17:33 INFO - 'LOGNAME': 'cltbld', 10:17:33 INFO - 'MAIL': '/var/mail/cltbld', 10:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:33 INFO - 'MOZ_NO_REMOTE': '1', 10:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:33 INFO - 'NO_EM_RESTART': '1', 10:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:33 INFO - 'PWD': '/builds/slave/test', 10:17:33 INFO - 'SHELL': '/bin/bash', 10:17:33 INFO - 'SHLVL': '1', 10:17:33 INFO - 'TERM': 'linux', 10:17:33 INFO - 'TMOUT': '86400', 10:17:33 INFO - 'USER': 'cltbld', 10:17:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:33 INFO - '_': '/tools/buildbot/bin/python'} 10:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:34 INFO - Running setup.py (path:/tmp/pip-uqael1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:34 INFO - Running setup.py (path:/tmp/pip-diyvCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:34 INFO - Running setup.py (path:/tmp/pip-ZBpH7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:34 INFO - Running setup.py (path:/tmp/pip-d1Ns5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:34 INFO - Running setup.py (path:/tmp/pip-d83ymG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:34 INFO - Running setup.py (path:/tmp/pip-83cyKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:34 INFO - Running setup.py (path:/tmp/pip-wPfjBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:34 INFO - Running setup.py (path:/tmp/pip-0IvMlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:34 INFO - Running setup.py (path:/tmp/pip-BHFHIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:34 INFO - Running setup.py (path:/tmp/pip-DS7b1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:34 INFO - Running setup.py (path:/tmp/pip-SYbseG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:34 INFO - Running setup.py (path:/tmp/pip-b8j_Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:35 INFO - Running setup.py (path:/tmp/pip-gU9TYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:35 INFO - Running setup.py (path:/tmp/pip-w0eyVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:35 INFO - Running setup.py (path:/tmp/pip-nOeTiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:35 INFO - Running setup.py (path:/tmp/pip-E2CQQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:35 INFO - Running setup.py (path:/tmp/pip-CmCR1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:35 INFO - Running setup.py install for manifestparser 10:17:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:35 INFO - Running setup.py install for mozcrash 10:17:35 INFO - Running setup.py install for mozdebug 10:17:35 INFO - Running setup.py install for mozdevice 10:17:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:17:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:35 INFO - Running setup.py install for mozfile 10:17:35 INFO - Running setup.py install for mozhttpd 10:17:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Running setup.py install for mozinfo 10:17:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Running setup.py install for mozInstall 10:17:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Running setup.py install for mozleak 10:17:36 INFO - Running setup.py install for mozlog 10:17:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Running setup.py install for moznetwork 10:17:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Running setup.py install for mozprocess 10:17:36 INFO - Running setup.py install for mozprofile 10:17:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Running setup.py install for mozrunner 10:17:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:36 INFO - Running setup.py install for mozscreenshot 10:17:36 INFO - Running setup.py install for moztest 10:17:37 INFO - Running setup.py install for mozversion 10:17:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:37 INFO - Cleaning up... 10:17:37 INFO - Return code: 0 10:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:37 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')]} 10:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:37 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')]} 10:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:37 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 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:37 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 10:17:37 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 10:17:37 INFO - Using env: {'DISPLAY': ':0', 10:17:37 INFO - 'HOME': '/home/cltbld', 10:17:37 INFO - 'LANG': 'en_US.UTF-8', 10:17:37 INFO - 'LANGUAGE': 'en_US:en', 10:17:37 INFO - 'LOGNAME': 'cltbld', 10:17:37 INFO - 'MAIL': '/var/mail/cltbld', 10:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:37 INFO - 'MOZ_NO_REMOTE': '1', 10:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:37 INFO - 'NO_EM_RESTART': '1', 10:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:37 INFO - 'PWD': '/builds/slave/test', 10:17:37 INFO - 'SHELL': '/bin/bash', 10:17:37 INFO - 'SHLVL': '1', 10:17:37 INFO - 'TERM': 'linux', 10:17:37 INFO - 'TMOUT': '86400', 10:17:37 INFO - 'USER': 'cltbld', 10:17:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:37 INFO - '_': '/tools/buildbot/bin/python'} 10:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:37 INFO - Running setup.py (path:/tmp/pip-6Lk3j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:37 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)) 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:37 INFO - Running setup.py (path:/tmp/pip-HEXm_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:37 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)) 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:37 INFO - Running setup.py (path:/tmp/pip-dj68Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:37 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)) 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:37 INFO - Running setup.py (path:/tmp/pip-57PDMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:37 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)) 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:37 INFO - Running setup.py (path:/tmp/pip-DiBjuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:37 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)) 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:37 INFO - Running setup.py (path:/tmp/pip-kayEkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:37 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)) 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:37 INFO - Running setup.py (path:/tmp/pip-52lRer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:37 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)) 10:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:37 INFO - Running setup.py (path:/tmp/pip-YrkcUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:38 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:38 INFO - Running setup.py (path:/tmp/pip-7o9PEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:38 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:38 INFO - Running setup.py (path:/tmp/pip-OVfkdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:38 INFO - Running setup.py (path:/tmp/pip-oha_v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:38 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:38 INFO - Running setup.py (path:/tmp/pip-djX4q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:38 INFO - Running setup.py (path:/tmp/pip-7h2wdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:38 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:38 INFO - Running setup.py (path:/tmp/pip-z_mXoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:38 INFO - Running setup.py (path:/tmp/pip-BAJl4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:38 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:38 INFO - Running setup.py (path:/tmp/pip-4tJlrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:38 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)) 10:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:38 INFO - Running setup.py (path:/tmp/pip-RRp0Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:38 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)) 10:17:38 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)) 10:17:38 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)) 10:17:38 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)) 10:17:38 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)) 10:17:38 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)) 10:17:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:38 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 10:17:38 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 10:17:38 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 10:17:38 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 10:17:38 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 10:17:38 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 10:17:40 INFO - Downloading blessings-1.6.tar.gz 10:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:40 INFO - Installing collected packages: blessings 10:17:40 INFO - Running setup.py install for blessings 10:17:40 INFO - Successfully installed blessings 10:17:40 INFO - Cleaning up... 10:17:40 INFO - Return code: 0 10:17:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:41 INFO - Reading from file tmpfile_stdout 10:17:41 INFO - Current package versions: 10:17:41 INFO - argparse == 1.2.1 10:17:41 INFO - blessings == 1.6 10:17:41 INFO - blobuploader == 1.2.4 10:17:41 INFO - docopt == 0.6.1 10:17:41 INFO - functools32 == 3.2.3-2 10:17:41 INFO - jsonschema == 2.5.1 10:17:41 INFO - manifestparser == 1.1 10:17:41 INFO - mozInstall == 1.12 10:17:41 INFO - mozcrash == 0.17 10:17:41 INFO - mozdebug == 0.1 10:17:41 INFO - mozdevice == 0.48 10:17:41 INFO - mozfile == 1.2 10:17:41 INFO - mozhttpd == 0.7 10:17:41 INFO - mozinfo == 0.9 10:17:41 INFO - mozleak == 0.1 10:17:41 INFO - mozlog == 3.2 10:17:41 INFO - moznetwork == 0.27 10:17:41 INFO - mozprocess == 0.23 10:17:41 INFO - mozprofile == 0.28 10:17:41 INFO - mozrunner == 6.12 10:17:41 INFO - mozscreenshot == 0.1 10:17:41 INFO - mozsystemmonitor == 0.3 10:17:41 INFO - moztest == 0.7 10:17:41 INFO - mozversion == 1.4 10:17:41 INFO - psutil == 3.1.1 10:17:41 INFO - requests == 1.2.3 10:17:41 INFO - wsgiref == 0.1.2 10:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:41 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 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:41 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 10:17:41 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 10:17:41 INFO - Using env: {'DISPLAY': ':0', 10:17:41 INFO - 'HOME': '/home/cltbld', 10:17:41 INFO - 'LANG': 'en_US.UTF-8', 10:17:41 INFO - 'LANGUAGE': 'en_US:en', 10:17:41 INFO - 'LOGNAME': 'cltbld', 10:17:41 INFO - 'MAIL': '/var/mail/cltbld', 10:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:41 INFO - 'MOZ_NO_REMOTE': '1', 10:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:41 INFO - 'NO_EM_RESTART': '1', 10:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:41 INFO - 'PWD': '/builds/slave/test', 10:17:41 INFO - 'SHELL': '/bin/bash', 10:17:41 INFO - 'SHLVL': '1', 10:17:41 INFO - 'TERM': 'linux', 10:17:41 INFO - 'TMOUT': '86400', 10:17:41 INFO - 'USER': 'cltbld', 10:17:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:41 INFO - '_': '/tools/buildbot/bin/python'} 10:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 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)) 10:17:41 INFO - Cleaning up... 10:17:41 INFO - Return code: 0 10:17:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:41 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 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:41 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 10:17:41 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 10:17:41 INFO - Using env: {'DISPLAY': ':0', 10:17:41 INFO - 'HOME': '/home/cltbld', 10:17:41 INFO - 'LANG': 'en_US.UTF-8', 10:17:41 INFO - 'LANGUAGE': 'en_US:en', 10:17:41 INFO - 'LOGNAME': 'cltbld', 10:17:41 INFO - 'MAIL': '/var/mail/cltbld', 10:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:41 INFO - 'MOZ_NO_REMOTE': '1', 10:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:41 INFO - 'NO_EM_RESTART': '1', 10:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:41 INFO - 'PWD': '/builds/slave/test', 10:17:41 INFO - 'SHELL': '/bin/bash', 10:17:41 INFO - 'SHLVL': '1', 10:17:41 INFO - 'TERM': 'linux', 10:17:41 INFO - 'TMOUT': '86400', 10:17:41 INFO - 'USER': 'cltbld', 10:17:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:41 INFO - '_': '/tools/buildbot/bin/python'} 10:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:17:41 INFO - Cleaning up... 10:17:41 INFO - Return code: 0 10:17:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:41 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 0x7fbc1d9edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', '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 10:17:41 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 10:17:41 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 10:17:41 INFO - Using env: {'DISPLAY': ':0', 10:17:41 INFO - 'HOME': '/home/cltbld', 10:17:41 INFO - 'LANG': 'en_US.UTF-8', 10:17:41 INFO - 'LANGUAGE': 'en_US:en', 10:17:41 INFO - 'LOGNAME': 'cltbld', 10:17:41 INFO - 'MAIL': '/var/mail/cltbld', 10:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:41 INFO - 'MOZ_NO_REMOTE': '1', 10:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:41 INFO - 'NO_EM_RESTART': '1', 10:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:41 INFO - 'PWD': '/builds/slave/test', 10:17:41 INFO - 'SHELL': '/bin/bash', 10:17:41 INFO - 'SHLVL': '1', 10:17:41 INFO - 'TERM': 'linux', 10:17:41 INFO - 'TMOUT': '86400', 10:17:41 INFO - 'USER': 'cltbld', 10:17:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:41 INFO - '_': '/tools/buildbot/bin/python'} 10:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:41 INFO - Downloading/unpacking flake8 10:17:41 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 10:17:41 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 10:17:41 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 10:17:41 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 10:17:41 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 10:17:41 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 10:17:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:17:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:17:43 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 10:17:43 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 10:17:43 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 10:17:43 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 10:17:43 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 10:17:43 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 10:17:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:17:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:17:43 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 10:17:43 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 10:17:43 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 10:17:43 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 10:17:43 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 10:17:43 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 10:17:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:44 INFO - no previously-included directories found matching 'docs/_build' 10:17:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:17:44 INFO - Running setup.py install for pep8 10:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:44 INFO - no previously-included directories found matching 'docs/_build' 10:17:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:17:44 INFO - Cleaning up... 10:17:44 INFO - Return code: 0 10:17:44 INFO - Running post-action listener: _resource_record_post_action 10:17:44 INFO - Running post-action listener: _start_resource_monitoring 10:17:44 INFO - Starting resource monitoring. 10:17:44 INFO - ##### 10:17:44 INFO - ##### Finished create-virtualenv step (success) 10:17:44 INFO - ##### 10:17:44 INFO - ##### 10:17:44 INFO - ##### Running install step. 10:17:44 INFO - ##### 10:17:44 INFO - Running pre-action listener: _resource_record_pre_action 10:17:44 INFO - Running main action method: install 10:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:44 INFO - Reading from file tmpfile_stdout 10:17:44 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:44 INFO - Reading from file tmpfile_stdout 10:17:44 INFO - Output received: 10:17:44 INFO - Usage: mozinstall [options] installer 10:17:44 INFO - Options: 10:17:44 INFO - -h, --help show this help message and exit 10:17:44 INFO - -d DEST, --destination=DEST 10:17:44 INFO - Directory to install application into. [default: 10:17:44 INFO - "/builds/slave/test"] 10:17:44 INFO - --app=APP Application being installed. [default: firefox] 10:17:44 INFO - mkdir: /builds/slave/test/build/application 10:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:18:00 INFO - Reading from file tmpfile_stdout 10:18:00 INFO - Output received: 10:18:00 INFO - /builds/slave/test/build/application/firefox/firefox 10:18:00 INFO - Running post-action listener: _resource_record_post_action 10:18:00 INFO - ##### 10:18:00 INFO - ##### Finished install step (success) 10:18:00 INFO - ##### 10:18:00 INFO - ##### 10:18:00 INFO - ##### Running run-tests step. 10:18:00 INFO - ##### 10:18:00 INFO - Running pre-action listener: _resource_record_pre_action 10:18:00 INFO - Running main action method: run_tests 10:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:00 INFO - Python 2.7.3 10:18:00 INFO - Return code: 0 10:18:00 INFO - grabbing minidump binary from tooltool 10:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19841c0>, '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 0x19850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1985550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:00 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 10:18:00 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 10:18:00 INFO - Calling ['/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'] with output_timeout 600 10:18:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:00 INFO - Return code: 0 10:18:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:18:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:18:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:18:01 INFO - Return code: 0 10:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 10:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 10:18:01 INFO - Using env: {'DISPLAY': ':0', 10:18:01 INFO - 'HOME': '/home/cltbld', 10:18:01 INFO - 'LANG': 'en_US.UTF-8', 10:18:01 INFO - 'LANGUAGE': 'en_US:en', 10:18:01 INFO - 'LOGNAME': 'cltbld', 10:18:01 INFO - 'MAIL': '/var/mail/cltbld', 10:18:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:01 INFO - 'MOZ_NO_REMOTE': '1', 10:18:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:01 INFO - 'NO_EM_RESTART': '1', 10:18:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:01 INFO - 'PWD': '/builds/slave/test', 10:18:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:01 INFO - 'SHELL': '/bin/bash', 10:18:01 INFO - 'SHLVL': '1', 10:18:01 INFO - 'TERM': 'linux', 10:18:01 INFO - 'TMOUT': '86400', 10:18:01 INFO - 'USER': 'cltbld', 10:18:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841', 10:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:01 INFO - '_': '/tools/buildbot/bin/python'} 10:18:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 10:18:02 INFO - mozversion application_buildid: 20160726073608 10:18:02 INFO - mozversion application_changeset: 2a0c3fd014516cd8718395e25a8cecd1fa29e0cb 10:18:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:18:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:02 INFO - mozversion application_name: Firefox 10:18:02 INFO - mozversion application_remotingname: firefox-dev 10:18:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:18:02 INFO - mozversion application_vendor: Mozilla 10:18:02 INFO - mozversion application_version: 49.0a2 10:18:02 INFO - mozversion platform_buildid: 20160726073608 10:18:02 INFO - mozversion platform_changeset: 2a0c3fd014516cd8718395e25a8cecd1fa29e0cb 10:18:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:18:02 INFO - mozversion platform_version: 49.0a2 10:18:02 INFO - using testdate: 1469553482 10:18:02 INFO - actual date: 1469553482 10:18:02 INFO - starting webserver on 'localhost:39297' 10:18:02 INFO - SUITE-START | Running 2 tests 10:18:02 INFO - TEST-START | dromaeo_css 10:18:02 INFO - operating with platform_type : linux_ 10:18:02 INFO - Initialising browser for dromaeo_css test... 10:18:02 INFO - TEST-INFO | started process 14123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZnLWDE/profile http://localhost:39297/getInfo.html) 10:18:05 INFO - PROCESS | 14123 | __metrics Screen width/height:1600/1200 10:18:05 INFO - PROCESS | 14123 | colorDepth:24 10:18:05 INFO - PROCESS | 14123 | Browser inner width/height: 1024/697 10:18:05 INFO - PROCESS | 14123 | __metrics 10:18:06 INFO - PROCESS | 14123 | 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" 10:18:06 ERROR - PROCESS | 14123 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:18:07 INFO - TEST-INFO | 14123: exit 0 10:18:07 INFO - Browser initialized. 10:18:07 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:07 INFO - TEST-INFO | started process 14218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZnLWDE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:19 INFO - PROCESS | 14218 | RSS: Main: 145690624 10:18:19 INFO - PROCESS | 14218 | 10:19:10 INFO - PROCESS | 14218 | 1469553550396 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] 10:21:18 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39297/tests/dromaeo/cssquery-ext.html) 10:21:19 INFO - PROCESS | 14218 | RSS: Main: 253513728 10:21:19 INFO - PROCESS | 14218 | 10:24:21 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-ext.html (next: http://localhost:39297/tests/dromaeo/cssquery-jquery.html) 10:24:22 INFO - PROCESS | 14218 | RSS: Main: 236380160 10:24:22 INFO - PROCESS | 14218 | 10:27:24 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39297/tests/dromaeo/cssquery-mootools.html) 10:27:24 INFO - PROCESS | 14218 | RSS: Main: 231223296 10:27:24 INFO - PROCESS | 14218 | 10:30:26 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39297/tests/dromaeo/cssquery-prototype.html) 10:30:27 INFO - PROCESS | 14218 | RSS: Main: 221106176 10:30:27 INFO - PROCESS | 14218 | 10:33:30 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39297/tests/dromaeo/cssquery-yui.html) 10:33:30 INFO - PROCESS | 14218 | RSS: Main: 215859200 10:33:30 INFO - PROCESS | 14218 | 10:36:32 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-yui.html (next: http://localhost:39297/tests/dromaeo/cssquery-dojo.html) 10:36:33 INFO - PROCESS | 14218 | RSS: Main: 246292480 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | __start_tp_report 10:36:33 INFO - PROCESS | 14218 | _x_x_mozilla_page_load 10:36:33 INFO - PROCESS | 14218 | _x_x_mozilla_page_load_details 10:36:33 INFO - PROCESS | 14218 | |i|pagename|runs| 10:36:33 INFO - PROCESS | 14218 | |0;dojo.html;3242.4974129010006;3282.2943067240544;3305.6859598338165;3322.7674062815613;3355.4463513520272;5437.102878025126;5498.835034948953;5519.806806761764;5522.22688823565;5549.0289199390145;5471.261379713737;5548.4174161713045;5558.082916318803;5567.164925261213;5583.022970980072;4900.093482705711;4950.207966725334;4999.050180465718;5043.167877300241;5071.290019397287;4861.197902346109;5012.598992080643;5045.041442126003;5054.090263752523;5059.595232381419;4935.950640493603;4948.455669876311;5005.9499405005845;5018.34761481007;5023.698578085308;5062.063518249099;5068.366454193226;5070.847874563769;5081.161608334621;5108.66793658411;4811.278308253755;4932.358793356877;4973;4990.25146228065;4994.850154495371;5331.706756128411;5335.9466405336225;5343.572514198893;5367.329083864517;5399.433059528771;5916.378780228057;5952.672603006833;5953.791617293417;5959.225300710923;5960.552958528127;5877.353491115974;5921.171036054956;5947.078202878561;5988.341282458926;5991.670458124801;5600.2674397137935;5605.607607467479;5617.691026993513;5629.887402251973;5636.859078522988;5824.941750582525;6086.69136135733;6098.803411973913;6101.8474538136015;6134.9079763803575;5741.253637027244;5842.707864606753;5855.94144058554;5878;5888.998870192077;5934.43622855828;5939.376365481562;5939.673317967553;5966.522678185735;5973.55198360116;5722.828315150552;5832.416758324133;5899.056151015817;5906.379830117861;5909.468147866713;5915.438033386908;5966.463018328372;5971.0744834550715;5973.522118230618;6002.459778619946;4570.177368073712;4575.450945886515;4582.908341833211;4586.220342541776;4610.077984403133;3989.860354887565;3995.2409042282457;4046.433499310099;4103.4870641169855;4145.606167414091;5651.265335506358;5655.717214139277;5681.147827825776;5682.062459694187;5696.6582005079;5943.673097979653;5957.195778569838;5978.043513037893;5986.012307969137;5996.730147143389;5378.623496355218;5554.333479982428;5596.440355964371;5623.634463759842;5663.122216056518;5082.974585127125;5091.134507133722;5117.513836185556;5123.923141152885;5125.692458452505;6129.141920131275;6132.908006379907;6142.692865356715;6148.477379422709;6151.72317245725;5758.021136406905;5906.527477801851;5934.6142500737315;5961.046232602763;6049.425304596057;6229.9139669041915;6257.5932564383165;6279.874402512016;6287.339829317856;6288.245410550763;5926.733297001731;5928.110783382354;5929.525637948867;5934.584579079596;5967.46292833647;5747.224124743273;5855.8536036597725;5892.616979896293;5921.319048309328;5975.790847320497;5795.217645617956;5823.301203855564;5831.125331200354;5839.386864379179;5846.093855452412;5650.802221922213;5766.279215098113;5824.5631577631;5839.766409343749;5842.1820945066875;5618.88762224745;5681.829545113653;5700.173474846207;5735.311762588349;5747.080467125407;5837.503812176013;5838.708064596838;5872.354041055395;5878.911816322673;5883.411658834082;5457.154141108134;5653.236813030188;5727.713614319184;5734.942650573607;5754.56840736938 10:36:33 INFO - PROCESS | 14218 | |1;ext.html;589.4076453164569;651.156752006152;655.498543614135;659.0147729144929;664.7573635622997;32928.67071329286;47031.76484117579;47799.522004779945;47823.76088119554;47852.999999999956;50319.74840125803;50996.74501627496;51078.23382649263;51152.74423627886;51186.488135118634;8245.381596380295;9068.909310906905;9215.400998935082;10604.257701960827;10882.455877206108;10862.34825910448;10962.397068161248;10962.451877406138;10964.671059868177;10965.83551246728;10950.945245273762;10970;10977.945110274437;10981.780364392707;10981.835272470918;8297.585120743968;10911.618093366733;11132.220744547885;11157.442127893573;11159.888401115966;10596.576136954513;10675.572977080907;10684.091852192572;10980.725481862937;10995;46131.76934115341;46193.53806461926;46573.06853862938;46669;46790.2981455275;3730.3098926698376;3748.6813620842263;3801.6958643308467;3966.6628336591425;3994.6404823565726;34990.650093498996;35558.21789591913;35747.82126089379;35800.82099589511;35866.46200306997;4542.250528662767;4584.174848527264;4634.652401069933;4708.293755936637;4798.856034318976;391947;392580;394105;395610;396461;39200.60799392027;40366.59633403629;40420.79789601033;71910.64044679848;72558;42045;42216.78891605522;42245.577544224776;42254.78872605618;42270;16088.839111608968;17826.46520604384;18155.909220453814;18170.18234179465;18172.90913545424;13892.305384730926;14258.00193986411;14287.142771433539;14584.270786460847;14595.854041459663;9314.115159059878;9350.158485736316;9355.391899526508;9379.765505862408;9419.481928493999;3541;3544.964550354515;3551.2187318789825;3582.659647333499;3596.6762991330907;1067.3755852826027;1076.6769969009265;1184.1829137894824;1206.5776978057786;1265.5950095969201;33061.18163500982;33065.17337066544;33092.33815323728;33185.336293274486;33272.66727332744;1196.7486827766268;1200.17188140183;1204.6928033351614;1225.1791299829135;1284.1909596954047;17236.138193090297;18012.36956706509;18117.728234076498;18869.43391698251;19507.219711211677;621564;626921;631126;631383;631913;65738.35654108686;67035.66482167559;67069.66465167643;67080.66459667769;67083.66458167679;1389;1430.3634882477197;1468.1704836767192;1472.698096890135;1496.1172907984342;33305;33956.49065264072;35114.64885351216;35151;35324.29351412906;58694;64092.679536602016;64154.67922660543;64180.35819641744;64217.036744447934;566410;571450;571538;572852;572920;38328.80835595804;38367.808160959015;38693.419598706605;40323.99190020273;42547.36178957256;48676.5132348672;48982.755086224344;49841.501584983685;50519.24221136759;50600.74699626478;41422.1715565693;41616.3757543631;41868.581314187686;42682.359764604174;43440.56559434365;40394.79802601086;40521.79739101286;41636.37545436881;41918.790406047774;42172.57827421809;41728.58271417247;42197.789011054745;42537.36193957031;42556.14887702167;42919.356209657504;36270.4559431614;37416.251674966894;37781;37931.431028535146;38248.61751382451;28363.149105526867;28413.289667757643;29018.7098129016;29050.12849614515;29085.563716544693 10:36:33 INFO - PROCESS | 14218 | |2;jquery.html;426.6394896312615;427.9957200427996;433.1575086456842;434.6327353386387;439.09765432037153;18620.25518979241;19719.802801971975;20302.89848550759;21008.789912100874;21026.789732102676;19536.41390758276;19662.901685491554;19744.901275493638;20210.09054592543;20296.289629862957;5711.7715291388295;5869.413058694139;5911.142884281777;5915.408459154071;5917.615355001933;5684.943150568503;5789.305283365981;5814.534837213013;5850.707464626773;5854.619449735775;5742.97128514359;5755.194272801811;5755.539556835443;5755.65466072037;5772.220750198732;5365.302510673627;5694.117411801157;5702.600817942745;5770.3652598214585;5778.104393818965;5516.889662206773;5564.4713752193475;5581.190727344512;5940.524758019391;5942.494887934531;13178;13574.45702171912;13606.455741770318;13859.099158554662;13866.098703584235;2299.9425014374774;2320.791128798416;2324.9651255231183;2342.9648555271683;2391.988040059806;9830.459324737136;10139.138173255282;10147.594096236142;10385.89614103857;10580.576776928914;2000.0899590686204;2045.5602045560126;2060.4951786812176;2077.1172251793078;2135.135270215565;56523;76179;76748;86389;86529;11270.943645281885;11302.15233857464;11425.428728563706;11527;11872.584459543874;14274.714505709828;14611.123332600078;15066.171360575274;15269.160196189094;16512.75230871538;8160.551169685724;8384.203500667427;8909.10908909117;9050.592723327467;9064.410813297114;8842.159994800484;8958.372913896095;8960.148785865333;8964.596593153325;9055.954720226357;4959.429665588431;4979.551840334388;5024.974875125674;5042.571381432546;5072.873178170576;2010.8894010829545;2041.2447394464143;2083.19796878203;2095.245711543843;2115.598036373115;944.367273926471;1062.4740753327153;1089.9073578745738;1102.079763397572;1117.1455384062417;19197.616047679247;19562.119704613327;19708.802911970695;19974.70037949432;20070.698939515918;1056.1603525197486;1063.2822844579878;1106.3251416635846;1111.3165403277087;1135.437958210691;9767.51162441875;10575.153987680967;10866.565337386415;10925.617603383844;11175.497102630401;496567;533855;538627;542438;560045.4987979601;81639.59180204061;100787.49606252069;101642.4917875406;104768;105562;1103.1450625765096;1116.4808364110565;1124.4096849154096;1129.9999999999836;1136.7158210447387;17844.55388615295;17974.64050718952;18143.546411339823;18309;18484.260629574666;42455.7877210612;42545.361819572114;42688.14623707571;43580.56419435765;44008.33987490126;58692.413075870405;60389.69805150946;60478;60637.393626063174;60714.39285607264;7373.483856130019;7670.7315243966195;8295.543745094077;8473.067962523994;8625.82748345017;12349.444275007467;13002.609921702364;13049.412776425273;13049.804252936023;13283.00377471674;11158.163137764537;11208.887911120784;11309.095272378354;11455.885441145481;11571.363575003119;5762.884742305214;10314.02016808402;11105.888941110485;11145.108391328837;11297.887021130013;11210.775784484102;11331.206815522833;11368.147388946027;11539.8269025963;11721.179517433698;7872.56700881457;7930.603469826601;7977.042754869452;8001.919980800118;8120.066192387951;10252.436116013392;11363.147763917905;11561.30632162073;11583.942080289544;11752 10:36:33 INFO - PROCESS | 14218 | |3;mootools.html;1481.8221813382395;1603.9358425662979;1635.985688872899;1859.2377125378598;1946.9805301946976;9491.715248542547;9981.151602113829;10000.049995250449;10003.399796012236;10007.399556026643;9754.902450975487;9935.453550054744;9935.602575896974;9938.900610993887;9943.651972180975;2097.2764396283333;2346.6128088865316;2425.2360506440414;2439.8536087834786;2453.2272334214754;2435.5007223519137;2437.597796363607;2450.019992003204;2450.742672019439;2450.791682706972;2384.380061184096;2407.879606019701;2450.656908032877;2456.091246238894;2460.729319774823;2068.720722702431;2283.7373702024315;2356.929292121239;2369.3010561884284;2373.8338316317863;2455.6071028635333;2470.295965649781;2483.3915690655726;2492.0779311654805;2492.6884139482563;9873.506324683736;9883.703488895273;9901.950490247575;9945.403275803475;9948.104670579683;5408.323959505062;5528.889422211573;5529.778808847641;5534.723263836832;5535.391106978229;3402.268512269874;3422.828858557062;3462.307538492312;3472.6353732858192;3553.040679016651;1083.6369816111612;1089.8256278995402;1111.4220605285286;1122.0518661730905;1123.8370436286693;13783.586492405244;13907.721845563134;13940.163590184622;13942.51201207963;13963.860361396357;4699.814586217357;4778.1399348117675;4788.784504697297;4857.951420485821;4928.186849169847;11507.482163302671;11529.250598711056;11547.480363383667;11569.6529104127;11582.6525204244;5356.143017117321;5371.5702743781185;5378.273933019071;5378.596605254622;5378.97310513445;4592.908141837144;5093.465186155475;5247.1866860636665;5248.553872920768;5308.973455132699;4340.262155433584;4341.131773645284;4357.281048627005;4401.405810215644;4404.295312749945;1345.3676771917183;1362.189497249155;1404.43120536183;1411.5765270419038;1420.488624095325;826.3678286111129;918.1002617434951;951.0014484790942;996.1980605612551;1026.2303272545591;6063;6299.96850015747;6494.707738151795;6538.411542961157;6593.274739778621;452.01460815422695;476.86647738632547;477.13876453002666;489.1049379635259;496.02283501501984;4188.979055104705;4216.346466297668;4293;4298.570142985676;4310.159518893785;12162.331071790959;12529.248245105322;12585.119041666996;12590.937045314715;12632.2420654761;12446.937765311115;12508.937455312665;12514;12532.310722910144;12551.372431378395;8094.271515563628;8408.369372297102;8411.663533458715;8624.310055195694;9056.818863622822;6289.591176573508;6475.546711730322;6526.575772574767;6592.868142637025;6655.467562595078;11317.830232546354;11463.541458341573;11645.184837061324;11775.352355620524;11803.704907377385;11683.123765717435;11830.704232394259;11850.703732406759;11967;11972.102092342935;7408.925910740823;7932.6430310635005;8112.878306825284;8693.434926729742;8804.64781408762;9112.271018318386;9124.406913550598;9166.908330916605;9198.310126740387;9208.401453905475;8063.153368896182;8212.507249565046;8312.542810145258;8364.498130112213;8420.747377578682;7857.882131768142;7923.841523169389;8055.113937466991;8094.757157285291;8208.753737387888;7184.892226616709;7196.532225405332;7233.0597022386755;7263.128424589083;7275;5027.824026159067;5040.400920602963;5049.924251136163;5086.21163719624;5105.591552675703;5041.168207245763;5091.745412729423;5126.256692779451;5191.844244672666;5212.296339994053 10:36:33 INFO - PROCESS | 14218 | |4;prototype.html;341.88546836809667;348.54688904424256;353.91152211947013;354.7339495378466;361.7485847336099;5398.514133727964;5435.972820135904;5451.509364157225;5453.809116680917;5484.957858006976;5356.437574054717;5364.678119312844;5375.946240537593;5379.81170659027;5385.649932754368;3868.4390763339297;4061.1877624475073;4180.979095104521;4213.662906967435;4232.11125663611;4195.160967806451;4213.367994800774;4218.936715949263;4228.809703563347;4245.811172871586;4017.899552511196;4213.915721685565;4216.536181020086;4217.514985776645;4237.4491316129015;4124.072083781155;4232.640225580829;4238.872833814959;4252.489701235841;4262.616364527192;3766.4162054881535;3775.62243775623;3778.7732736035928;3789.6399842014966;3798.753081049723;5242.842714718565;5258.186870024557;5265.52610265078;5268.631195816294;5317.1492561190025;4862.708237505725;4899.779509922062;4905.3132561441425;4921.753912304371;4925.802967881281;5354.625176237665;5438.395673276354;5581.2186293918885;5642.153676948449;5664.405237450091;4000.8599699010397;4108.876733697994;4133.400656904762;4139.151473947833;4141.151064031867;5786.276715410574;5815.331236907725;5848.327442344143;5853.560982926298;5858.209141765892;4118.773467459258;4255.340422234559;4259.829606815692;4273.230818452646;4278.016056307067;4286.828526858953;4332.393464914914;4338;4348.304271316638;4359.346098085249;4892.87160085364;4913.729744864067;4913.778879950411;4917.926231106536;4941.234108713155;5524.447555244524;5672.574556908248;5683.4884860361935;5691.857703557444;5692;1477.6158198868372;1483.8293596236356;1490.4187366926908;1498.7751837224503;1504.886384075776;923.7806095953277;948.5778828421425;965.3347974743511;966.7969726357403;973.9172170365457;4864.659473836798;4865.6107511399005;4882.36529251195;4890.6550698558185;4908;5081.695098294041;5170.250313704491;5182.4299327073995;5198.870028249324;5201.3238279024245;4687.20317546018;4917.557419832232;4945.357103576512;4955.82654607087;4981.352424184833;2809.8876044958383;2818.8167769094944;2823.901163459269;2825.660920689489;2830.476361873019;5423.891522169534;5436.266104075899;5443.755031023614;5466.371367292732;5468.507834294933;5275.017361891747;5293.550048245866;5489.478499542537;5974.970125149433;5977.910331345033;5848.53211743068;5956.225690660186;6079.209702738615;6141.7543298267565;6147.508199344042;5824.155497452761;5835.387284335254;5857.853553661193;5869.911951320648;5876.383994401574;5599.748011339581;5751.597388182954;5779.450952159538;5783.768649253982;5799.63708528487;6084.665343406155;6088.543359248163;6106.175666284995;6125.162451264514;6181.752729890754;4156.854510092132;4168.54146043941;4180.979095104505;4184.267753143248;4190.559991201002;5628.831135065954;5919.763209471573;5935.228420305505;5956.523478121653;5966.433188847052;5778.306603207642;5805.651660900359;5812.244408226903;5815.94184058171;5818.418158184148;5619.775208991595;5677.403872593483;5744.798932037359;5788.479036886701;5806.303243610793;5612.522935550524;5626.746796394254;5640.5769567281795;5651.971740141437;5675.41088495222;5755.769769209185;5799.246098007232;5806.5645076618575;5815.854603634773;5821.243238378984;5487.917681234864;5655.773769049192;5663.518600918968;5674.751554657969;5688.943110569007 10:36:33 INFO - PROCESS | 14218 | |5;yui.html;801.6993627389729;801.7795106345754;842.4902933725097;871.869219617057;878.8286284174586;14793.630159246011;15727;15733.685326293467;15811.209439528035;15956.281967311455;15010.849891501082;15047.623809404742;15053.92473037636;15097.54707358781;15138.697226055472;851.489106536078;876.2814492116468;878.7583414560983;880.5949263338872;881.180502133016;856.4775486952954;860.1484530314974;861.1087524412235;866.3502373220085;866.4368160695535;895.1630225738922;897.4929165021741;897.6768363389175;899.536738579632;902.1429641840278;888.4536010353651;894.767360486275;895.0512456795817;895.50299583731;895.771578247546;659;660.451824985261;660.7621256347711;661.0711949710665;661.441082285468;15119;15146.318415671321;15156.469523566733;15178.772318415233;15179.924100379538;14572.125672459686;14728.779068313985;14804.777928331083;15132.470363537223;15218.923905380512;12918;12963.740725185444;13014.609561713163;13068.411921463558;13291.933540332333;4784.832530861438;4869.707817530924;4877.780499877514;4894.877628059291;4979.203327467588;48391.75804120992;78869.21130788676;79269.60365198195;79929.20070799276;79933.60033199855;12486.937565312115;12592.496300147892;12637;13199;13214.405351759195;24362.87818560896;24797.1321003764;24841.25476235716;24902.37744056413;24915.377115572257;9327.113924177193;9421.24630029596;9552.14030737237;9556.522173891277;9562.856557151648;5098.413682426494;5153.974230128901;5225.608079394061;5250.579953603703;5278.841634750964;3755.6244375562223;3873.4770805941403;3881.029742564359;3883.126296583246;3884.378499440076;679.0832376291967;681.655763839258;683.5147045597582;685.5817951049855;693.38635307753;578.733782460073;635.4281146967766;769.7498313048281;771.5949126708523;796.5977181523409;9923.305368624271;10446.947765261126;10466.162706983576;10669.19981001428;10700.892991070144;701.0850839654198;707.5471698113212;711.4735096029004;712.3482013957171;730.0578667968097;4083.5508094109623;4456.710313829591;4489.506154323022;4497.8425755098415;4570.88572785683;66122.66938665276;66397.6680116606;110020;111876.32185517224;118032;82129;97355.51322243344;97488.51255743676;97596.51201743945;99361;80572;89634.10365896388;90960;91721.54139229261;92923.4245945232;10016.899831001889;10404.843927340944;10458.424786636808;10479.842802357818;10617.628383006559;52085.21872171845;52507;52631.47368526419;53603.19595206153;54678.453215467336;45616;63111;77895.61052194703;79866.6006669963;80082.1991780098;13176.670583235113;14740.631484212981;14763.409463621334;14825.184614846286;14842.480513181987;15215.543533693564;15612.375504979673;15855.286512107214;15880.2059897007;15916.28376723027;14048.470163577947;14258.572242832732;14345.426182952566;14481.420743170154;14586.781198281822;14016.929915350358;14077.436902523785;14079.225642589756;14198.716025679221;14267.500637477639;13653.931730341683;13685.521006764715;13686.247256400993;13707.451701931812;14010.509632162826;10975.615853445091;11259.549618015188;11366.261193022427;11437.542498299976;11484.19610627248;11132.721681958015;11823.113266504875;12049.269447878458;12183.451744671334;12396.938015309866 10:36:33 INFO - PROCESS | 14218 | __end_tp_report 10:36:33 INFO - PROCESS | 14218 | __start_cc_report 10:36:33 INFO - PROCESS | 14218 | _x_x_mozilla_cycle_collect,894 10:36:33 INFO - PROCESS | 14218 | __end_cc_report 10:36:33 INFO - PROCESS | 14218 | __startTimestamp1469554593178__endTimestamp 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | ------- Summary: start ------- 10:36:33 INFO - PROCESS | 14218 | Number of tests: 6 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | [#0] dojo.html Cycles:165 Average:5509.92 Median:5727.71 stddev:624.99 (10.9%) stddev-sans-first:601.06 10:36:33 INFO - PROCESS | 14218 | Values: 3242.5 3282.3 3305.7 3322.8 3355.4 5437.1 5498.8 5519.8 5522.2 5549.0 5471.3 5548.4 5558.1 5567.2 5583.0 4900.1 4950.2 4999.1 5043.2 5071.3 4861.2 5012.6 5045.0 5054.1 5059.6 4936.0 4948.5 5005.9 5018.3 5023.7 5062.1 5068.4 5070.8 5081.2 5108.7 4811.3 4932.4 4973.0 4990.3 4994.9 5331.7 5335.9 5343.6 5367.3 5399.4 5916.4 5952.7 5953.8 5959.2 5960.6 5877.4 5921.2 5947.1 5988.3 5991.7 5600.3 5605.6 5617.7 5629.9 5636.9 5824.9 6086.7 6098.8 6101.8 6134.9 5741.3 5842.7 5855.9 5878.0 5889.0 5934.4 5939.4 5939.7 5966.5 5973.6 5722.8 5832.4 5899.1 5906.4 5909.5 5915.4 5966.5 5971.1 5973.5 6002.5 4570.2 4575.5 4582.9 4586.2 4610.1 3989.9 3995.2 4046.4 4103.5 4145.6 5651.3 5655.7 5681.1 5682.1 5696.7 5943.7 5957.2 5978.0 5986.0 5996.7 5378.6 5554.3 5596.4 5623.6 5663.1 5083.0 5091.1 5117.5 5123.9 5125.7 6129.1 6132.9 6142.7 6148.5 6151.7 5758.0 5906.5 5934.6 5961.0 6049.4 6229.9 6257.6 6279.9 6287.3 6288.2 5926.7 5928.1 5929.5 5934.6 5967.5 5747.2 5855.9 5892.6 5921.3 5975.8 5795.2 5823.3 5831.1 5839.4 5846.1 5650.8 5766.3 5824.6 5839.8 5842.2 5618.9 5681.8 5700.2 5735.3 5747.1 5837.5 5838.7 5872.4 5878.9 5883.4 5457.2 5653.2 5727.7 5734.9 5754.6 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | [#1] ext.html Cycles:180 Average:68745.59 Median:393342.50 stddev:144081.11 (36.6%) stddev-sans-first:144394.42 10:36:33 INFO - PROCESS | 14218 | Values: 589.4 651.2 655.5 659.0 664.8 32928.7 47031.8 47799.5 47823.8 47853.0 50319.7 50996.7 51078.2 51152.7 51186.5 8245.4 9068.9 9215.4 10604.3 10882.5 10862.3 10962.4 10962.5 10964.7 10965.8 10950.9 10970.0 10977.9 10981.8 10981.8 8297.6 10911.6 11132.2 11157.4 11159.9 10596.6 10675.6 10684.1 10980.7 10995.0 46131.8 46193.5 46573.1 46669.0 46790.3 3730.3 3748.7 3801.7 3966.7 3994.6 34990.7 35558.2 35747.8 35800.8 35866.5 4542.3 4584.2 4634.7 4708.3 4798.9 391947.0 392580.0 394105.0 395610.0 396461.0 39200.6 40366.6 40420.8 71910.6 72558.0 42045.0 42216.8 42245.6 42254.8 42270.0 16088.8 17826.5 18155.9 18170.2 18172.9 13892.3 14258.0 14287.1 14584.3 14595.9 9314.1 9350.2 9355.4 9379.8 9419.5 3541.0 3545.0 3551.2 3582.7 3596.7 1067.4 1076.7 1184.2 1206.6 1265.6 33061.2 33065.2 33092.3 33185.3 33272.7 1196.7 1200.2 1204.7 1225.2 1284.2 17236.1 18012.4 18117.7 18869.4 19507.2 621564.0 626921.0 631126.0 631383.0 631913.0 65738.4 67035.7 67069.7 67080.7 67083.7 1389.0 1430.4 1468.2 1472.7 1496.1 33305.0 33956.5 35114.6 35151.0 35324.3 58694.0 64092.7 64154.7 64180.4 64217.0 566410.0 571450.0 571538.0 572852.0 572920.0 38328.8 38367.8 38693.4 40324.0 42547.4 48676.5 48982.8 49841.5 50519.2 50600.7 41422.2 41616.4 41868.6 42682.4 43440.6 40394.8 40521.8 41636.4 41918.8 42172.6 41728.6 42197.8 42537.4 42556.1 42919.4 36270.5 37416.3 37781.0 37931.4 38248.6 28363.1 28413.3 29018.7 29050.1 29085.6 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | [#2] jquery.html Cycles:180 Average:30182.67 Median:11552.02 stddev:88098.99 (762.6%) stddev-sans-first:88317.80 10:36:33 INFO - PROCESS | 14218 | Values: 426.6 428.0 433.2 434.6 439.1 18620.3 19719.8 20302.9 21008.8 21026.8 19536.4 19662.9 19744.9 20210.1 20296.3 5711.8 5869.4 5911.1 5915.4 5917.6 5684.9 5789.3 5814.5 5850.7 5854.6 5743.0 5755.2 5755.5 5755.7 5772.2 5365.3 5694.1 5702.6 5770.4 5778.1 5516.9 5564.5 5581.2 5940.5 5942.5 13178.0 13574.5 13606.5 13859.1 13866.1 2299.9 2320.8 2325.0 2343.0 2392.0 9830.5 10139.1 10147.6 10385.9 10580.6 2000.1 2045.6 2060.5 2077.1 2135.1 56523.0 76179.0 76748.0 86389.0 86529.0 11270.9 11302.2 11425.4 11527.0 11872.6 14274.7 14611.1 15066.2 15269.2 16512.8 8160.6 8384.2 8909.1 9050.6 9064.4 8842.2 8958.4 8960.1 8964.6 9056.0 4959.4 4979.6 5025.0 5042.6 5072.9 2010.9 2041.2 2083.2 2095.2 2115.6 944.4 1062.5 1089.9 1102.1 1117.1 19197.6 19562.1 19708.8 19974.7 20070.7 1056.2 1063.3 1106.3 1111.3 1135.4 9767.5 10575.2 10866.6 10925.6 11175.5 496567.0 533855.0 538627.0 542438.0 560045.5 81639.6 100787.5 101642.5 104768.0 105562.0 1103.1 1116.5 1124.4 1130.0 1136.7 17844.6 17974.6 18143.5 18309.0 18484.3 42455.8 42545.4 42688.1 43580.6 44008.3 58692.4 60389.7 60478.0 60637.4 60714.4 7373.5 7670.7 8295.5 8473.1 8625.8 12349.4 13002.6 13049.4 13049.8 13283.0 11158.2 11208.9 11309.1 11455.9 11571.4 5762.9 10314.0 11105.9 11145.1 11297.9 11210.8 11331.2 11368.1 11539.8 11721.2 7872.6 7930.6 7977.0 8001.9 8120.1 10252.4 11363.1 11561.3 11583.9 11752.0 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | [#3] mootools.html Cycles:180 Average:6295.69 Median:4646.36 stddev:3812.92 (82.1%) stddev-sans-first:3806.46 10:36:33 INFO - PROCESS | 14218 | Values: 1481.8 1603.9 1636.0 1859.2 1947.0 9491.7 9981.2 10000.0 10003.4 10007.4 9754.9 9935.5 9935.6 9938.9 9943.7 2097.3 2346.6 2425.2 2439.9 2453.2 2435.5 2437.6 2450.0 2450.7 2450.8 2384.4 2407.9 2450.7 2456.1 2460.7 2068.7 2283.7 2356.9 2369.3 2373.8 2455.6 2470.3 2483.4 2492.1 2492.7 9873.5 9883.7 9902.0 9945.4 9948.1 5408.3 5528.9 5529.8 5534.7 5535.4 3402.3 3422.8 3462.3 3472.6 3553.0 1083.6 1089.8 1111.4 1122.1 1123.8 13783.6 13907.7 13940.2 13942.5 13963.9 4699.8 4778.1 4788.8 4858.0 4928.2 11507.5 11529.3 11547.5 11569.7 11582.7 5356.1 5371.6 5378.3 5378.6 5379.0 4592.9 5093.5 5247.2 5248.6 5309.0 4340.3 4341.1 4357.3 4401.4 4404.3 1345.4 1362.2 1404.4 1411.6 1420.5 826.4 918.1 951.0 996.2 1026.2 6063.0 6300.0 6494.7 6538.4 6593.3 452.0 476.9 477.1 489.1 496.0 4189.0 4216.3 4293.0 4298.6 4310.2 12162.3 12529.2 12585.1 12590.9 12632.2 12446.9 12508.9 12514.0 12532.3 12551.4 8094.3 8408.4 8411.7 8624.3 9056.8 6289.6 6475.5 6526.6 6592.9 6655.5 11317.8 11463.5 11645.2 11775.4 11803.7 11683.1 11830.7 11850.7 11967.0 11972.1 7408.9 7932.6 8112.9 8693.4 8804.6 9112.3 9124.4 9166.9 9198.3 9208.4 8063.2 8212.5 8312.5 8364.5 8420.7 7857.9 7923.8 8055.1 8094.8 8208.8 7184.9 7196.5 7233.1 7263.1 7275.0 5027.8 5040.4 5049.9 5086.2 5105.6 5041.2 5091.7 5126.3 5191.8 5212.3 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | [#4] prototype.html Cycles:180 Average:4726.40 Median:5305.35 stddev:1384.87 (26.1%) stddev-sans-first:1349.09 10:36:33 INFO - PROCESS | 14218 | Values: 341.9 348.5 353.9 354.7 361.7 5398.5 5436.0 5451.5 5453.8 5485.0 5356.4 5364.7 5375.9 5379.8 5385.6 3868.4 4061.2 4181.0 4213.7 4232.1 4195.2 4213.4 4218.9 4228.8 4245.8 4017.9 4213.9 4216.5 4217.5 4237.4 4124.1 4232.6 4238.9 4252.5 4262.6 3766.4 3775.6 3778.8 3789.6 3798.8 5242.8 5258.2 5265.5 5268.6 5317.1 4862.7 4899.8 4905.3 4921.8 4925.8 5354.6 5438.4 5581.2 5642.2 5664.4 4000.9 4108.9 4133.4 4139.2 4141.2 5786.3 5815.3 5848.3 5853.6 5858.2 4118.8 4255.3 4259.8 4273.2 4278.0 4286.8 4332.4 4338.0 4348.3 4359.3 4892.9 4913.7 4913.8 4917.9 4941.2 5524.4 5672.6 5683.5 5691.9 5692.0 1477.6 1483.8 1490.4 1498.8 1504.9 923.8 948.6 965.3 966.8 973.9 4864.7 4865.6 4882.4 4890.7 4908.0 5081.7 5170.3 5182.4 5198.9 5201.3 4687.2 4917.6 4945.4 4955.8 4981.4 2809.9 2818.8 2823.9 2825.7 2830.5 5423.9 5436.3 5443.8 5466.4 5468.5 5275.0 5293.6 5489.5 5975.0 5977.9 5848.5 5956.2 6079.2 6141.8 6147.5 5824.2 5835.4 5857.9 5869.9 5876.4 5599.7 5751.6 5779.5 5783.8 5799.6 6084.7 6088.5 6106.2 6125.2 6181.8 4156.9 4168.5 4181.0 4184.3 4190.6 5628.8 5919.8 5935.2 5956.5 5966.4 5778.3 5805.7 5812.2 5815.9 5818.4 5619.8 5677.4 5744.8 5788.5 5806.3 5612.5 5626.7 5640.6 5652.0 5675.4 5755.8 5799.2 5806.6 5815.9 5821.2 5487.9 5655.8 5663.5 5674.8 5688.9 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - PROCESS | 14218 | [#5] yui.html Cycles:180 Average:20469.92 Median:25056.92 stddev:28113.87 (112.2%) stddev-sans-first:28153.95 10:36:33 INFO - PROCESS | 14218 | Values: 801.7 801.8 842.5 871.9 878.8 14793.6 15727.0 15733.7 15811.2 15956.3 15010.8 15047.6 15053.9 15097.5 15138.7 851.5 876.3 878.8 880.6 881.2 856.5 860.1 861.1 866.4 866.4 895.2 897.5 897.7 899.5 902.1 888.5 894.8 895.1 895.5 895.8 659.0 660.5 660.8 661.1 661.4 15119.0 15146.3 15156.5 15178.8 15179.9 14572.1 14728.8 14804.8 15132.5 15218.9 12918.0 12963.7 13014.6 13068.4 13291.9 4784.8 4869.7 4877.8 4894.9 4979.2 48391.8 78869.2 79269.6 79929.2 79933.6 12486.9 12592.5 12637.0 13199.0 13214.4 24362.9 24797.1 24841.3 24902.4 24915.4 9327.1 9421.2 9552.1 9556.5 9562.9 5098.4 5154.0 5225.6 5250.6 5278.8 3755.6 3873.5 3881.0 3883.1 3884.4 679.1 681.7 683.5 685.6 693.4 578.7 635.4 769.7 771.6 796.6 9923.3 10446.9 10466.2 10669.2 10700.9 701.1 707.5 711.5 712.3 730.1 4083.6 4456.7 4489.5 4497.8 4570.9 66122.7 66397.7 110020.0 111876.3 118032.0 82129.0 97355.5 97488.5 97596.5 99361.0 80572.0 89634.1 90960.0 91721.5 92923.4 10016.9 10404.8 10458.4 10479.8 10617.6 52085.2 52507.0 52631.5 53603.2 54678.5 45616.0 63111.0 77895.6 79866.6 80082.2 13176.7 14740.6 14763.4 14825.2 14842.5 15215.5 15612.4 15855.3 15880.2 15916.3 14048.5 14258.6 14345.4 14481.4 14586.8 14016.9 14077.4 14079.2 14198.7 14267.5 13653.9 13685.5 13686.2 13707.5 14010.5 10975.6 11259.5 11366.3 11437.5 11484.2 11132.7 11823.1 12049.3 12183.5 12396.9 10:36:33 INFO - PROCESS | 14218 | -------- Summary: end -------- 10:36:33 INFO - PROCESS | 14218 | 10:36:33 INFO - TEST-INFO | 14218: exit 0 10:36:33 INFO - TEST-OK | dromaeo_css | took 1111932ms 10:36:33 INFO - TEST-START | kraken 10:36:33 INFO - operating with platform_type : linux_ 10:36:33 INFO - Initialising browser for kraken test... 10:36:33 INFO - TEST-INFO | started process 14410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYOUN3y/profile http://localhost:39297/getInfo.html) 10:36:37 INFO - PROCESS | 14410 | __metrics Screen width/height:1600/1200 10:36:37 INFO - PROCESS | 14410 | colorDepth:24 10:36:37 INFO - PROCESS | 14410 | Browser inner width/height: 1024/697 10:36:37 INFO - PROCESS | 14410 | __metrics 10:36:38 INFO - PROCESS | 14410 | 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" 10:36:38 ERROR - PROCESS | 14410 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:36:39 INFO - TEST-INFO | 14410: exit 0 10:36:39 INFO - Browser initialized. 10:36:39 INFO - Running cycle 1/1 for kraken test... 10:36:39 INFO - TEST-INFO | started process 14502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYOUN3y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:51 INFO - PROCESS | 14502 | RSS: Main: 144912384 10:36:51 INFO - PROCESS | 14502 | 10:36:53 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-beat-detection) 10:36:54 INFO - PROCESS | 14502 | RSS: Main: 194654208 10:36:54 INFO - PROCESS | 14502 | 10:36:57 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-dft) 10:36:57 INFO - PROCESS | 14502 | RSS: Main: 193056768 10:36:57 INFO - PROCESS | 14502 | 10:37:00 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-fft) 10:37:01 INFO - PROCESS | 14502 | RSS: Main: 278921216 10:37:01 INFO - PROCESS | 14502 | 10:37:03 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-oscillator) 10:37:03 INFO - PROCESS | 14502 | RSS: Main: 187416576 10:37:03 INFO - PROCESS | 14502 | 10:37:05 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:06 INFO - PROCESS | 14502 | RSS: Main: 188616704 10:37:06 INFO - PROCESS | 14502 | 10:37:09 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:10 INFO - PROCESS | 14502 | RSS: Main: 223457280 10:37:10 INFO - PROCESS | 14502 | 10:37:13 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-desaturate) 10:37:14 INFO - PROCESS | 14502 | RSS: Main: 224133120 10:37:14 INFO - PROCESS | 14502 | 10:37:16 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39297/tests/kraken/driver.html?testName=json-parse-financial) 10:37:17 INFO - PROCESS | 14502 | RSS: Main: 223805440 10:37:17 INFO - PROCESS | 14502 | 10:37:18 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:19 INFO - PROCESS | 14502 | RSS: Main: 201207808 10:37:19 INFO - PROCESS | 14502 | 10:37:21 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:21 INFO - PROCESS | 14502 | RSS: Main: 200978432 10:37:21 INFO - PROCESS | 14502 | 10:37:23 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:24 INFO - PROCESS | 14502 | RSS: Main: 206565376 10:37:24 INFO - PROCESS | 14502 | 10:37:27 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:27 INFO - PROCESS | 14502 | RSS: Main: 215228416 10:37:27 INFO - PROCESS | 14502 | 10:37:30 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:30 INFO - PROCESS | 14502 | RSS: Main: 215085056 10:37:30 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39297/tests/kraken/driver.html?testName=ai-astar) 10:37:32 INFO - PROCESS | 14502 | RSS: Main: 258469888 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | __start_tp_report 10:37:32 INFO - PROCESS | 14502 | _x_x_mozilla_page_load 10:37:32 INFO - PROCESS | 14502 | _x_x_mozilla_page_load_details 10:37:32 INFO - PROCESS | 14502 | |i|pagename|runs| 10:37:32 INFO - PROCESS | 14502 | |0;ai-astar;110;106;109;109;111;112;111;110;110;111 10:37:32 INFO - PROCESS | 14502 | |1;audio-beat-detection;149;127;124;175;126;124;156;124;161;125 10:37:32 INFO - PROCESS | 14502 | |2;audio-dft;161;163;160;160;161;161;161;161;160;160 10:37:32 INFO - PROCESS | 14502 | |3;audio-fft;74;75;76;133;75;76;74;74;102;74 10:37:32 INFO - PROCESS | 14502 | |4;audio-oscillator;85;84;115;84;84;84;114;84;84;132 10:37:32 INFO - PROCESS | 14502 | |5;imaging-gaussian-blur;119;118;120;116;117;116;117;116;117;116 10:37:32 INFO - PROCESS | 14502 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;145;145 10:37:32 INFO - PROCESS | 14502 | |7;imaging-desaturate;96;95;94;94;94;94;95;94;95;95 10:37:32 INFO - PROCESS | 14502 | |8;json-parse-financial;53;54;52;54;54;52;55;52;54;52 10:37:32 INFO - PROCESS | 14502 | |9;json-stringify-tinderbox;61;61;61;61;61;62;60;60;60;60 10:37:32 INFO - PROCESS | 14502 | |10;stanford-crypto-aes;76;80;76;76;78;78;78;78;115;77 10:37:32 INFO - PROCESS | 14502 | |11;stanford-crypto-ccm;121;118;115;117;125;126;122;117;131;122 10:37:32 INFO - PROCESS | 14502 | |12;stanford-crypto-pbkdf2;165;156;157;158;162;158;159;160;157;156 10:37:32 INFO - PROCESS | 14502 | |13;stanford-crypto-sha256-iterative;62;62;62;60;63;62;63;61;61;67 10:37:32 INFO - PROCESS | 14502 | __end_tp_report 10:37:32 INFO - PROCESS | 14502 | __start_cc_report 10:37:32 INFO - PROCESS | 14502 | _x_x_mozilla_cycle_collect,1621 10:37:32 INFO - PROCESS | 14502 | __end_cc_report 10:37:32 INFO - PROCESS | 14502 | __startTimestamp1469554652878__endTimestamp 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | ------- Summary: start ------- 10:37:32 INFO - PROCESS | 14502 | Number of tests: 14 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.66 (1.5%) stddev-sans-first:1.76 10:37:32 INFO - PROCESS | 14502 | Values: 110.0 106.0 109.0 109.0 111.0 112.0 111.0 110.0 110.0 111.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:138.00 stddev:19.30 (14.0%) stddev-sans-first:20.14 10:37:32 INFO - PROCESS | 14502 | Values: 149.0 127.0 124.0 175.0 126.0 124.0 156.0 124.0 161.0 125.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:37:32 INFO - PROCESS | 14502 | Values: 161.0 163.0 160.0 160.0 161.0 161.0 161.0 161.0 160.0 160.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#3] audio-fft Cycles:10 Average:83.30 Median:74.50 stddev:19.47 (26.1%) stddev-sans-first:20.35 10:37:32 INFO - PROCESS | 14502 | Values: 74.0 75.0 76.0 133.0 75.0 76.0 74.0 74.0 102.0 74.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:84.00 stddev:18.12 (21.6%) stddev-sans-first:18.86 10:37:32 INFO - PROCESS | 14502 | Values: 85.0 84.0 115.0 84.0 84.0 84.0 114.0 84.0 84.0 132.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:1.40 (1.2%) stddev-sans-first:1.32 10:37:32 INFO - PROCESS | 14502 | Values: 119.0 118.0 120.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:37:32 INFO - PROCESS | 14502 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 10:37:32 INFO - PROCESS | 14502 | Values: 96.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:54.00 stddev:1.14 (2.1%) stddev-sans-first:1.20 10:37:32 INFO - PROCESS | 14502 | Values: 53.0 54.0 52.0 54.0 54.0 52.0 55.0 52.0 54.0 52.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:37:32 INFO - PROCESS | 14502 | Values: 61.0 61.0 61.0 61.0 61.0 62.0 60.0 60.0 60.0 60.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:78.00 stddev:11.94 (15.3%) stddev-sans-first:12.52 10:37:32 INFO - PROCESS | 14502 | Values: 76.0 80.0 76.0 76.0 78.0 78.0 78.0 78.0 115.0 77.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.00 stddev:4.93 (4.0%) stddev-sans-first:5.22 10:37:32 INFO - PROCESS | 14502 | Values: 121.0 118.0 115.0 117.0 125.0 126.0 122.0 117.0 131.0 122.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:158.50 stddev:2.86 (1.8%) stddev-sans-first:1.96 10:37:32 INFO - PROCESS | 14502 | Values: 165.0 156.0 157.0 158.0 162.0 158.0 159.0 160.0 157.0 156.0 10:37:32 INFO - PROCESS | 14502 | 10:37:32 INFO - PROCESS | 14502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.89 (3.0%) stddev-sans-first:2.00 10:37:32 INFO - PROCESS | 14502 | Values: 62.0 62.0 62.0 60.0 63.0 62.0 63.0 61.0 61.0 67.0 10:37:32 INFO - PROCESS | 14502 | -------- Summary: end -------- 10:37:32 INFO - PROCESS | 14502 | 10:37:33 INFO - TEST-INFO | 14502: exit 0 10:37:33 INFO - TEST-OK | kraken | took 59879ms 10:37:33 INFO - SUITE-END | took 1171s 10:37:34 INFO - Completed test suite (00:19:32) 10:37:34 INFO - javascript benchmark 10:37:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3242.4974129010006, 3282.2943067240544, 3305.6859598338165, 3322.7674062815613, 3355.4463513520272, 5437.102878025126, 5498.835034948953, 5519.806806761764, 5522.22688823565, 5549.0289199390145, 5471.261379713737, 5548.4174161713045, 5558.082916318803, 5567.164925261213, 5583.022970980072, 4900.093482705711, 4950.207966725334, 4999.050180465718, 5043.167877300241, 5071.290019397287, 4861.197902346109, 5012.598992080643, 5045.041442126003, 5054.090263752523, 5059.595232381419, 4935.950640493603, 4948.455669876311, 5005.9499405005845, 5018.34761481007, 5023.698578085308, 5062.063518249099, 5068.366454193226, 5070.847874563769, 5081.161608334621, 5108.66793658411, 4811.278308253755, 4932.358793356877, 4973.0, 4990.25146228065, 4994.850154495371, 5331.706756128411, 5335.9466405336225, 5343.572514198893, 5367.329083864517, 5399.433059528771, 5916.378780228057, 5952.672603006833, 5953.791617293417, 5959.225300710923, 5960.552958528127, 5877.353491115974, 5921.171036054956, 5947.078202878561, 5988.341282458926, 5991.670458124801, 5600.2674397137935, 5605.607607467479, 5617.691026993513, 5629.887402251973, 5636.859078522988, 5824.941750582525, 6086.69136135733, 6098.803411973913, 6101.8474538136015, 6134.9079763803575, 5741.253637027244, 5842.707864606753, 5855.94144058554, 5878.0, 5888.998870192077, 5934.43622855828, 5939.376365481562, 5939.673317967553, 5966.522678185735, 5973.55198360116, 5722.828315150552, 5832.416758324133, 5899.056151015817, 5906.379830117861, 5909.468147866713, 5915.438033386908, 5966.463018328372, 5971.0744834550715, 5973.522118230618, 6002.459778619946, 4570.177368073712, 4575.450945886515, 4582.908341833211, 4586.220342541776, 4610.077984403133, 3989.860354887565, 3995.2409042282457, 4046.433499310099, 4103.4870641169855, 4145.606167414091, 5651.265335506358, 5655.717214139277, 5681.147827825776, 5682.062459694187, 5696.6582005079, 5943.673097979653, 5957.195778569838, 5978.043513037893, 5986.012307969137, 5996.730147143389, 5378.623496355218, 5554.333479982428, 5596.440355964371, 5623.634463759842, 5663.122216056518, 5082.974585127125, 5091.134507133722, 5117.513836185556, 5123.923141152885, 5125.692458452505, 6129.141920131275, 6132.908006379907, 6142.692865356715, 6148.477379422709, 6151.72317245725, 5758.021136406905, 5906.527477801851, 5934.6142500737315, 5961.046232602763, 6049.425304596057, 6229.9139669041915, 6257.5932564383165, 6279.874402512016, 6287.339829317856, 6288.245410550763, 5926.733297001731, 5928.110783382354, 5929.525637948867, 5934.584579079596, 5967.46292833647, 5747.224124743273, 5855.8536036597725, 5892.616979896293, 5921.319048309328, 5975.790847320497, 5795.217645617956, 5823.301203855564, 5831.125331200354, 5839.386864379179, 5846.093855452412, 5650.802221922213, 5766.279215098113, 5824.5631577631, 5839.766409343749, 5842.1820945066875, 5618.88762224745, 5681.829545113653, 5700.173474846207, 5735.311762588349, 5747.080467125407, 5837.503812176013, 5838.708064596838, 5872.354041055395, 5878.911816322673, 5883.411658834082, 5457.154141108134, 5653.236813030188, 5727.713614319184, 5734.942650573607, 5754.56840736938], "value": 5468.60986032398, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4076453164569, 651.156752006152, 655.498543614135, 659.0147729144929, 664.7573635622997, 32928.67071329286, 47031.76484117579, 47799.522004779945, 47823.76088119554, 47852.999999999956, 50319.74840125803, 50996.74501627496, 51078.23382649263, 51152.74423627886, 51186.488135118634, 8245.381596380295, 9068.909310906905, 9215.400998935082, 10604.257701960827, 10882.455877206108, 10862.34825910448, 10962.397068161248, 10962.451877406138, 10964.671059868177, 10965.83551246728, 10950.945245273762, 10970.0, 10977.945110274437, 10981.780364392707, 10981.835272470918, 8297.585120743968, 10911.618093366733, 11132.220744547885, 11157.442127893573, 11159.888401115966, 10596.576136954513, 10675.572977080907, 10684.091852192572, 10980.725481862937, 10995.0, 46131.76934115341, 46193.53806461926, 46573.06853862938, 46669.0, 46790.2981455275, 3730.3098926698376, 3748.6813620842263, 3801.6958643308467, 3966.6628336591425, 3994.6404823565726, 34990.650093498996, 35558.21789591913, 35747.82126089379, 35800.82099589511, 35866.46200306997, 4542.250528662767, 4584.174848527264, 4634.652401069933, 4708.293755936637, 4798.856034318976, 391947.0, 392580.0, 394105.0, 395610.0, 396461.0, 39200.60799392027, 40366.59633403629, 40420.79789601033, 71910.64044679848, 72558.0, 42045.0, 42216.78891605522, 42245.577544224776, 42254.78872605618, 42270.0, 16088.839111608968, 17826.46520604384, 18155.909220453814, 18170.18234179465, 18172.90913545424, 13892.305384730926, 14258.00193986411, 14287.142771433539, 14584.270786460847, 14595.854041459663, 9314.115159059878, 9350.158485736316, 9355.391899526508, 9379.765505862408, 9419.481928493999, 3541.0, 3544.964550354515, 3551.2187318789825, 3582.659647333499, 3596.6762991330907, 1067.3755852826027, 1076.6769969009265, 1184.1829137894824, 1206.5776978057786, 1265.5950095969201, 33061.18163500982, 33065.17337066544, 33092.33815323728, 33185.336293274486, 33272.66727332744, 1196.7486827766268, 1200.17188140183, 1204.6928033351614, 1225.1791299829135, 1284.1909596954047, 17236.138193090297, 18012.36956706509, 18117.728234076498, 18869.43391698251, 19507.219711211677, 621564.0, 626921.0, 631126.0, 631383.0, 631913.0, 65738.35654108686, 67035.66482167559, 67069.66465167643, 67080.66459667769, 67083.66458167679, 1389.0, 1430.3634882477197, 1468.1704836767192, 1472.698096890135, 1496.1172907984342, 33305.0, 33956.49065264072, 35114.64885351216, 35151.0, 35324.29351412906, 58694.0, 64092.679536602016, 64154.67922660543, 64180.35819641744, 64217.036744447934, 566410.0, 571450.0, 571538.0, 572852.0, 572920.0, 38328.80835595804, 38367.808160959015, 38693.419598706605, 40323.99190020273, 42547.36178957256, 48676.5132348672, 48982.755086224344, 49841.501584983685, 50519.24221136759, 50600.74699626478, 41422.1715565693, 41616.3757543631, 41868.581314187686, 42682.359764604174, 43440.56559434365, 40394.79802601086, 40521.79739101286, 41636.37545436881, 41918.790406047774, 42172.57827421809, 41728.58271417247, 42197.789011054745, 42537.36193957031, 42556.14887702167, 42919.356209657504, 36270.4559431614, 37416.251674966894, 37781.0, 37931.431028535146, 38248.61751382451, 28363.149105526867, 28413.289667757643, 29018.7098129016, 29050.12849614515, 29085.563716544693], "value": 21055.309096994897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.6394896312615, 427.9957200427996, 433.1575086456842, 434.6327353386387, 439.09765432037153, 18620.25518979241, 19719.802801971975, 20302.89848550759, 21008.789912100874, 21026.789732102676, 19536.41390758276, 19662.901685491554, 19744.901275493638, 20210.09054592543, 20296.289629862957, 5711.7715291388295, 5869.413058694139, 5911.142884281777, 5915.408459154071, 5917.615355001933, 5684.943150568503, 5789.305283365981, 5814.534837213013, 5850.707464626773, 5854.619449735775, 5742.97128514359, 5755.194272801811, 5755.539556835443, 5755.65466072037, 5772.220750198732, 5365.302510673627, 5694.117411801157, 5702.600817942745, 5770.3652598214585, 5778.104393818965, 5516.889662206773, 5564.4713752193475, 5581.190727344512, 5940.524758019391, 5942.494887934531, 13178.0, 13574.45702171912, 13606.455741770318, 13859.099158554662, 13866.098703584235, 2299.9425014374774, 2320.791128798416, 2324.9651255231183, 2342.9648555271683, 2391.988040059806, 9830.459324737136, 10139.138173255282, 10147.594096236142, 10385.89614103857, 10580.576776928914, 2000.0899590686204, 2045.5602045560126, 2060.4951786812176, 2077.1172251793078, 2135.135270215565, 56523.0, 76179.0, 76748.0, 86389.0, 86529.0, 11270.943645281885, 11302.15233857464, 11425.428728563706, 11527.0, 11872.584459543874, 14274.714505709828, 14611.123332600078, 15066.171360575274, 15269.160196189094, 16512.75230871538, 8160.551169685724, 8384.203500667427, 8909.10908909117, 9050.592723327467, 9064.410813297114, 8842.159994800484, 8958.372913896095, 8960.148785865333, 8964.596593153325, 9055.954720226357, 4959.429665588431, 4979.551840334388, 5024.974875125674, 5042.571381432546, 5072.873178170576, 2010.8894010829545, 2041.2447394464143, 2083.19796878203, 2095.245711543843, 2115.598036373115, 944.367273926471, 1062.4740753327153, 1089.9073578745738, 1102.079763397572, 1117.1455384062417, 19197.616047679247, 19562.119704613327, 19708.802911970695, 19974.70037949432, 20070.698939515918, 1056.1603525197486, 1063.2822844579878, 1106.3251416635846, 1111.3165403277087, 1135.437958210691, 9767.51162441875, 10575.153987680967, 10866.565337386415, 10925.617603383844, 11175.497102630401, 496567.0, 533855.0, 538627.0, 542438.0, 560045.4987979601, 81639.59180204061, 100787.49606252069, 101642.4917875406, 104768.0, 105562.0, 1103.1450625765096, 1116.4808364110565, 1124.4096849154096, 1129.9999999999836, 1136.7158210447387, 17844.55388615295, 17974.64050718952, 18143.546411339823, 18309.0, 18484.260629574666, 42455.7877210612, 42545.361819572114, 42688.14623707571, 43580.56419435765, 44008.33987490126, 58692.413075870405, 60389.69805150946, 60478.0, 60637.393626063174, 60714.39285607264, 7373.483856130019, 7670.7315243966195, 8295.543745094077, 8473.067962523994, 8625.82748345017, 12349.444275007467, 13002.609921702364, 13049.412776425273, 13049.804252936023, 13283.00377471674, 11158.163137764537, 11208.887911120784, 11309.095272378354, 11455.885441145481, 11571.363575003119, 5762.884742305214, 10314.02016808402, 11105.888941110485, 11145.108391328837, 11297.887021130013, 11210.775784484102, 11331.206815522833, 11368.147388946027, 11539.8269025963, 11721.179517433698, 7872.56700881457, 7930.603469826601, 7977.042754869452, 8001.919980800118, 8120.066192387951, 10252.436116013392, 11363.147763917905, 11561.30632162073, 11583.942080289544, 11752.0], "value": 9272.497765153323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.8221813382395, 1603.9358425662979, 1635.985688872899, 1859.2377125378598, 1946.9805301946976, 9491.715248542547, 9981.151602113829, 10000.049995250449, 10003.399796012236, 10007.399556026643, 9754.902450975487, 9935.453550054744, 9935.602575896974, 9938.900610993887, 9943.651972180975, 2097.2764396283333, 2346.6128088865316, 2425.2360506440414, 2439.8536087834786, 2453.2272334214754, 2435.5007223519137, 2437.597796363607, 2450.019992003204, 2450.742672019439, 2450.791682706972, 2384.380061184096, 2407.879606019701, 2450.656908032877, 2456.091246238894, 2460.729319774823, 2068.720722702431, 2283.7373702024315, 2356.929292121239, 2369.3010561884284, 2373.8338316317863, 2455.6071028635333, 2470.295965649781, 2483.3915690655726, 2492.0779311654805, 2492.6884139482563, 9873.506324683736, 9883.703488895273, 9901.950490247575, 9945.403275803475, 9948.104670579683, 5408.323959505062, 5528.889422211573, 5529.778808847641, 5534.723263836832, 5535.391106978229, 3402.268512269874, 3422.828858557062, 3462.307538492312, 3472.6353732858192, 3553.040679016651, 1083.6369816111612, 1089.8256278995402, 1111.4220605285286, 1122.0518661730905, 1123.8370436286693, 13783.586492405244, 13907.721845563134, 13940.163590184622, 13942.51201207963, 13963.860361396357, 4699.814586217357, 4778.1399348117675, 4788.784504697297, 4857.951420485821, 4928.186849169847, 11507.482163302671, 11529.250598711056, 11547.480363383667, 11569.6529104127, 11582.6525204244, 5356.143017117321, 5371.5702743781185, 5378.273933019071, 5378.596605254622, 5378.97310513445, 4592.908141837144, 5093.465186155475, 5247.1866860636665, 5248.553872920768, 5308.973455132699, 4340.262155433584, 4341.131773645284, 4357.281048627005, 4401.405810215644, 4404.295312749945, 1345.3676771917183, 1362.189497249155, 1404.43120536183, 1411.5765270419038, 1420.488624095325, 826.3678286111129, 918.1002617434951, 951.0014484790942, 996.1980605612551, 1026.2303272545591, 6063.0, 6299.96850015747, 6494.707738151795, 6538.411542961157, 6593.274739778621, 452.01460815422695, 476.86647738632547, 477.13876453002666, 489.1049379635259, 496.02283501501984, 4188.979055104705, 4216.346466297668, 4293.0, 4298.570142985676, 4310.159518893785, 12162.331071790959, 12529.248245105322, 12585.119041666996, 12590.937045314715, 12632.2420654761, 12446.937765311115, 12508.937455312665, 12514.0, 12532.310722910144, 12551.372431378395, 8094.271515563628, 8408.369372297102, 8411.663533458715, 8624.310055195694, 9056.818863622822, 6289.591176573508, 6475.546711730322, 6526.575772574767, 6592.868142637025, 6655.467562595078, 11317.830232546354, 11463.541458341573, 11645.184837061324, 11775.352355620524, 11803.704907377385, 11683.123765717435, 11830.704232394259, 11850.703732406759, 11967.0, 11972.102092342935, 7408.925910740823, 7932.6430310635005, 8112.878306825284, 8693.434926729742, 8804.64781408762, 9112.271018318386, 9124.406913550598, 9166.908330916605, 9198.310126740387, 9208.401453905475, 8063.153368896182, 8212.507249565046, 8312.542810145258, 8364.498130112213, 8420.747377578682, 7857.882131768142, 7923.841523169389, 8055.113937466991, 8094.757157285291, 8208.753737387888, 7184.892226616709, 7196.532225405332, 7233.0597022386755, 7263.128424589083, 7275.0, 5027.824026159067, 5040.400920602963, 5049.924251136163, 5086.21163719624, 5105.591552675703, 5041.168207245763, 5091.745412729423, 5126.256692779451, 5191.844244672666, 5212.296339994053], "value": 4851.518654228307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.88546836809667, 348.54688904424256, 353.91152211947013, 354.7339495378466, 361.7485847336099, 5398.514133727964, 5435.972820135904, 5451.509364157225, 5453.809116680917, 5484.957858006976, 5356.437574054717, 5364.678119312844, 5375.946240537593, 5379.81170659027, 5385.649932754368, 3868.4390763339297, 4061.1877624475073, 4180.979095104521, 4213.662906967435, 4232.11125663611, 4195.160967806451, 4213.367994800774, 4218.936715949263, 4228.809703563347, 4245.811172871586, 4017.899552511196, 4213.915721685565, 4216.536181020086, 4217.514985776645, 4237.4491316129015, 4124.072083781155, 4232.640225580829, 4238.872833814959, 4252.489701235841, 4262.616364527192, 3766.4162054881535, 3775.62243775623, 3778.7732736035928, 3789.6399842014966, 3798.753081049723, 5242.842714718565, 5258.186870024557, 5265.52610265078, 5268.631195816294, 5317.1492561190025, 4862.708237505725, 4899.779509922062, 4905.3132561441425, 4921.753912304371, 4925.802967881281, 5354.625176237665, 5438.395673276354, 5581.2186293918885, 5642.153676948449, 5664.405237450091, 4000.8599699010397, 4108.876733697994, 4133.400656904762, 4139.151473947833, 4141.151064031867, 5786.276715410574, 5815.331236907725, 5848.327442344143, 5853.560982926298, 5858.209141765892, 4118.773467459258, 4255.340422234559, 4259.829606815692, 4273.230818452646, 4278.016056307067, 4286.828526858953, 4332.393464914914, 4338.0, 4348.304271316638, 4359.346098085249, 4892.87160085364, 4913.729744864067, 4913.778879950411, 4917.926231106536, 4941.234108713155, 5524.447555244524, 5672.574556908248, 5683.4884860361935, 5691.857703557444, 5692.0, 1477.6158198868372, 1483.8293596236356, 1490.4187366926908, 1498.7751837224503, 1504.886384075776, 923.7806095953277, 948.5778828421425, 965.3347974743511, 966.7969726357403, 973.9172170365457, 4864.659473836798, 4865.6107511399005, 4882.36529251195, 4890.6550698558185, 4908.0, 5081.695098294041, 5170.250313704491, 5182.4299327073995, 5198.870028249324, 5201.3238279024245, 4687.20317546018, 4917.557419832232, 4945.357103576512, 4955.82654607087, 4981.352424184833, 2809.8876044958383, 2818.8167769094944, 2823.901163459269, 2825.660920689489, 2830.476361873019, 5423.891522169534, 5436.266104075899, 5443.755031023614, 5466.371367292732, 5468.507834294933, 5275.017361891747, 5293.550048245866, 5489.478499542537, 5974.970125149433, 5977.910331345033, 5848.53211743068, 5956.225690660186, 6079.209702738615, 6141.7543298267565, 6147.508199344042, 5824.155497452761, 5835.387284335254, 5857.853553661193, 5869.911951320648, 5876.383994401574, 5599.748011339581, 5751.597388182954, 5779.450952159538, 5783.768649253982, 5799.63708528487, 6084.665343406155, 6088.543359248163, 6106.175666284995, 6125.162451264514, 6181.752729890754, 4156.854510092132, 4168.54146043941, 4180.979095104505, 4184.267753143248, 4190.559991201002, 5628.831135065954, 5919.763209471573, 5935.228420305505, 5956.523478121653, 5966.433188847052, 5778.306603207642, 5805.651660900359, 5812.244408226903, 5815.94184058171, 5818.418158184148, 5619.775208991595, 5677.403872593483, 5744.798932037359, 5788.479036886701, 5806.303243610793, 5612.522935550524, 5626.746796394254, 5640.5769567281795, 5651.971740141437, 5675.41088495222, 5755.769769209185, 5799.246098007232, 5806.5645076618575, 5815.854603634773, 5821.243238378984, 5487.917681234864, 5655.773769049192, 5663.518600918968, 5674.751554657969, 5688.943110569007], "value": 4291.1107031715865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.6993627389729, 801.7795106345754, 842.4902933725097, 871.869219617057, 878.8286284174586, 14793.630159246011, 15727.0, 15733.685326293467, 15811.209439528035, 15956.281967311455, 15010.849891501082, 15047.623809404742, 15053.92473037636, 15097.54707358781, 15138.697226055472, 851.489106536078, 876.2814492116468, 878.7583414560983, 880.5949263338872, 881.180502133016, 856.4775486952954, 860.1484530314974, 861.1087524412235, 866.3502373220085, 866.4368160695535, 895.1630225738922, 897.4929165021741, 897.6768363389175, 899.536738579632, 902.1429641840278, 888.4536010353651, 894.767360486275, 895.0512456795817, 895.50299583731, 895.771578247546, 659.0, 660.451824985261, 660.7621256347711, 661.0711949710665, 661.441082285468, 15119.0, 15146.318415671321, 15156.469523566733, 15178.772318415233, 15179.924100379538, 14572.125672459686, 14728.779068313985, 14804.777928331083, 15132.470363537223, 15218.923905380512, 12918.0, 12963.740725185444, 13014.609561713163, 13068.411921463558, 13291.933540332333, 4784.832530861438, 4869.707817530924, 4877.780499877514, 4894.877628059291, 4979.203327467588, 48391.75804120992, 78869.21130788676, 79269.60365198195, 79929.20070799276, 79933.60033199855, 12486.937565312115, 12592.496300147892, 12637.0, 13199.0, 13214.405351759195, 24362.87818560896, 24797.1321003764, 24841.25476235716, 24902.37744056413, 24915.377115572257, 9327.113924177193, 9421.24630029596, 9552.14030737237, 9556.522173891277, 9562.856557151648, 5098.413682426494, 5153.974230128901, 5225.608079394061, 5250.579953603703, 5278.841634750964, 3755.6244375562223, 3873.4770805941403, 3881.029742564359, 3883.126296583246, 3884.378499440076, 679.0832376291967, 681.655763839258, 683.5147045597582, 685.5817951049855, 693.38635307753, 578.733782460073, 635.4281146967766, 769.7498313048281, 771.5949126708523, 796.5977181523409, 9923.305368624271, 10446.947765261126, 10466.162706983576, 10669.19981001428, 10700.892991070144, 701.0850839654198, 707.5471698113212, 711.4735096029004, 712.3482013957171, 730.0578667968097, 4083.5508094109623, 4456.710313829591, 4489.506154323022, 4497.8425755098415, 4570.88572785683, 66122.66938665276, 66397.6680116606, 110020.0, 111876.32185517224, 118032.0, 82129.0, 97355.51322243344, 97488.51255743676, 97596.51201743945, 99361.0, 80572.0, 89634.10365896388, 90960.0, 91721.54139229261, 92923.4245945232, 10016.899831001889, 10404.843927340944, 10458.424786636808, 10479.842802357818, 10617.628383006559, 52085.21872171845, 52507.0, 52631.47368526419, 53603.19595206153, 54678.453215467336, 45616.0, 63111.0, 77895.61052194703, 79866.6006669963, 80082.1991780098, 13176.670583235113, 14740.631484212981, 14763.409463621334, 14825.184614846286, 14842.480513181987, 15215.543533693564, 15612.375504979673, 15855.286512107214, 15880.2059897007, 15916.28376723027, 14048.470163577947, 14258.572242832732, 14345.426182952566, 14481.420743170154, 14586.781198281822, 14016.929915350358, 14077.436902523785, 14079.225642589756, 14198.716025679221, 14267.500637477639, 13653.931730341683, 13685.521006764715, 13686.247256400993, 13707.451701931812, 14010.509632162826, 10975.615853445091, 11259.549618015188, 11366.261193022427, 11437.542498299976, 11484.19610627248, 11132.721681958015, 11823.113266504875, 12049.269447878458, 12183.451744671334, 12396.938015309866], "value": 7904.931268822657, "unit": "score"}], "name": "dromaeo_css", "value": 7484.064641021197, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 109.0, 109.0, 111.0, 112.0, 111.0, 110.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 124.0, 175.0, 126.0, 124.0, 156.0, 124.0, 161.0, 125.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 133.0, 75.0, 76.0, 74.0, 74.0, 102.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 84.0, 84.0, 84.0, 114.0, 84.0, 84.0, 132.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 120.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 54.0, 54.0, 52.0, 55.0, 52.0, 54.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 60.0, 60.0, 60.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 76.0, 76.0, 78.0, 78.0, 78.0, 78.0, 115.0, 77.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 115.0, 117.0, 125.0, 126.0, 122.0, 117.0, 131.0, 122.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 156.0, 157.0, 158.0, 162.0, 158.0, 159.0, 160.0, 157.0, 156.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 60.0, 63.0, 62.0, 63.0, 61.0, 61.0, 67.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1483.1000000000001, "alertThreshold": 2.0}]} 10:37:34 INFO - Return code: 0 10:37:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:37:34 ERROR - # TBPL SUCCESS # 10:37:34 INFO - Running post-action listener: _resource_record_post_action 10:37:34 INFO - ##### 10:37:34 INFO - ##### Finished run-tests step (success) 10:37:34 INFO - ##### 10:37:34 INFO - Running post-run listener: _resource_record_post_run 10:37:34 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 286720; Write bytes: 507506688; Read time: 28; Write time: 385052 10:37:34 INFO - TinderboxPrint: CPU usage
13.1% 10:37:34 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 28 10:37:34 INFO - TinderboxPrint: I/O write bytes / time
507,506,688 / 385,052 10:37:34 INFO - TinderboxPrint: CPU idle
8,247.4 (86.9%) 10:37:34 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 10:37:34 INFO - TinderboxPrint: Swap in / out
0 / 0 10:37:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252514304; Read time: 0; Write time: 256172 10:37:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 254406656; Read time: 12; Write time: 128872 10:37:34 INFO - Running post-run listener: _upload_blobber_files 10:37:34 INFO - Blob upload gear active. 10:37:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:37:34 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 10:37:34 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:37:34 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:37:35 INFO - (blobuploader) - INFO - Open directory for files ... 10:37:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:37:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:37:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:38 INFO - (blobuploader) - INFO - Done attempting. 10:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:37:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:39 INFO - (blobuploader) - INFO - Done attempting. 10:37:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:37:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:37:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:40 INFO - (blobuploader) - INFO - Done attempting. 10:37:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:37:40 INFO - Return code: 0 10:37:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:37:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:37:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/069a0d2fe0920b38ddac9e2b53eb6e4e2db1fb324fd30c2b922033a89f3aa3efe1f79d3bf2c253224d3691f74efe1fb4d021123a95215815c7194b1392ba502d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f33e2aa849cf0b97cccfa4c30d1e9dbe96600d58b3a6654da22b1d720a3e2d0c31f7000d479d4304e85af29abfee7b9a21efdf5c2f6d0003be7353e7684123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e1b32ea20c2e82068e0a9ea5a088370e36275a2216b8d036baa522cd06202431035ea301a09e7d36785bbe9bee074f6c1e9e7b80fadf8ffb90305f440623d48"} 10:37:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:37:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:37:40 INFO - Contents: 10:37:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/069a0d2fe0920b38ddac9e2b53eb6e4e2db1fb324fd30c2b922033a89f3aa3efe1f79d3bf2c253224d3691f74efe1fb4d021123a95215815c7194b1392ba502d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f33e2aa849cf0b97cccfa4c30d1e9dbe96600d58b3a6654da22b1d720a3e2d0c31f7000d479d4304e85af29abfee7b9a21efdf5c2f6d0003be7353e7684123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e1b32ea20c2e82068e0a9ea5a088370e36275a2216b8d036baa522cd06202431035ea301a09e7d36785bbe9bee074f6c1e9e7b80fadf8ffb90305f440623d48"} 10:37:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:37:40 INFO - Copying logs to upload dir... 10:37:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:37:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.730129 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-26 10:37:39.827458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 10:37:39.831110) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841 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-Aurora/sha512/069a0d2fe0920b38ddac9e2b53eb6e4e2db1fb324fd30c2b922033a89f3aa3efe1f79d3bf2c253224d3691f74efe1fb4d021123a95215815c7194b1392ba502d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f33e2aa849cf0b97cccfa4c30d1e9dbe96600d58b3a6654da22b1d720a3e2d0c31f7000d479d4304e85af29abfee7b9a21efdf5c2f6d0003be7353e7684123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e1b32ea20c2e82068e0a9ea5a088370e36275a2216b8d036baa522cd06202431035ea301a09e7d36785bbe9bee074f6c1e9e7b80fadf8ffb90305f440623d48"} build_url:https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/arave6u_Q2y4jOoIU53dqA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/069a0d2fe0920b38ddac9e2b53eb6e4e2db1fb324fd30c2b922033a89f3aa3efe1f79d3bf2c253224d3691f74efe1fb4d021123a95215815c7194b1392ba502d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f33e2aa849cf0b97cccfa4c30d1e9dbe96600d58b3a6654da22b1d720a3e2d0c31f7000d479d4304e85af29abfee7b9a21efdf5c2f6d0003be7353e7684123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e1b32ea20c2e82068e0a9ea5a088370e36275a2216b8d036baa522cd06202431035ea301a09e7d36785bbe9bee074f6c1e9e7b80fadf8ffb90305f440623d48"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 10:37:39.862543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:37:39.863061) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469553326.963945-516474841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 10:37:39.944755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 10:37:39.945091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 10:37:39.945523) ========= ========= Total master_lag: 0.17 =========