builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1467987619.11 results: success (0) buildid: 20160708040825 builduid: 75d019f3c1f748868951ac2ae11eaf5e revision: dd939576757577e1580b84e0820f9eb2d77dd303 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.105839) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.106419) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.106837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.123126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.123456) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 07:20:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-07-08 07:20:19 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121426 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.259367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.259683) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020680 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.310908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:19.311344) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dd939576757577e1580b84e0820f9eb2d77dd303 --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 dd939576757577e1580b84e0820f9eb2d77dd303 --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=2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 07:20:19,600 truncating revision to first 12 chars 2016-07-08 07:20:19,600 Setting DEBUG logging. 2016-07-08 07:20:19,601 attempt 1/10 2016-07-08 07:20:19,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dd9395767575?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 07:20:20,122 unpacking tar archive at: mozilla-aurora-dd9395767575/testing/mozharness/ program finished with exit code 0 elapsedTime=0.848067 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:20.175587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:20.175941) ========= script_repo_revision: dd939576757577e1580b84e0820f9eb2d77dd303 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:20.176347) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:20.176729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 07:20:20.187129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-08 07:20:20.187400) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:20:20 INFO - MultiFileLogger online at 20160708 07:20:20 in /builds/slave/test 07:20:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:20:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:20:20 INFO - {'append_to_log': False, 07:20:20 INFO - 'base_work_dir': '/builds/slave/test', 07:20:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:20:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:20:20 INFO - 'branch': 'Mozilla-Aurora', 07:20:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:20:20 INFO - 'config_files': ('talos/linux_config.py',), 07:20:20 INFO - 'default_actions': ('clobber', 07:20:20 INFO - 'read-buildbot-config', 07:20:20 INFO - 'download-and-extract', 07:20:20 INFO - 'populate-webroot', 07:20:20 INFO - 'create-virtualenv', 07:20:20 INFO - 'install', 07:20:20 INFO - 'run-tests'), 07:20:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:20:20 INFO - 'download_minidump_stackwalk': True, 07:20:20 INFO - 'download_symbols': 'ondemand', 07:20:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:20:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:20:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:20:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:20:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:20:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:20:20 INFO - 'installer_path': 'installer.exe', 07:20:20 INFO - 'log_level': 'info', 07:20:20 INFO - 'log_name': 'talos', 07:20:20 INFO - 'log_to_console': True, 07:20:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:20:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:20:20 INFO - 'opt_config_files': (), 07:20:20 INFO - 'pip_index': False, 07:20:20 INFO - 'sps_profile': False, 07:20:20 INFO - 'sps_profile_interval': 0, 07:20:20 INFO - 'suite': 'dromaeojs-e10s', 07:20:20 INFO - 'system_bits': '32', 07:20:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:20:20 INFO - 'title': 'talos-linux64-ix-012', 07:20:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:20:20 INFO - 'use_talos_json': True, 07:20:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:20:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:20:20 INFO - 'work_dir': 'build'} 07:20:20 INFO - ##### 07:20:20 INFO - ##### Running clobber step. 07:20:20 INFO - ##### 07:20:20 INFO - Running pre-action listener: _resource_record_pre_action 07:20:20 INFO - Running main action method: clobber 07:20:20 INFO - rmtree: /builds/slave/test/build 07:20:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:20:21 INFO - Running post-action listener: _resource_record_post_action 07:20:21 INFO - ##### 07:20:21 INFO - ##### Finished clobber step (success) 07:20:21 INFO - ##### 07:20:21 INFO - ##### 07:20:21 INFO - ##### Running read-buildbot-config step. 07:20:21 INFO - ##### 07:20:21 INFO - Running pre-action listener: _resource_record_pre_action 07:20:21 INFO - Running main action method: read_buildbot_config 07:20:21 INFO - Using buildbot properties: 07:20:21 INFO - { 07:20:21 INFO - "project": "", 07:20:21 INFO - "product": "firefox", 07:20:21 INFO - "script_repo_revision": "production", 07:20:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:20:21 INFO - "repository": "", 07:20:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:20:21 INFO - "buildid": "20160708040825", 07:20:21 INFO - "pgo_build": "True", 07:20:21 INFO - "basedir": "/builds/slave/test", 07:20:21 INFO - "buildnumber": 437, 07:20:21 INFO - "slavename": "talos-linux64-ix-012", 07:20:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:20:21 INFO - "platform": "ubuntu64_hw", 07:20:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:20:21 INFO - "branch": "mozilla-aurora", 07:20:21 INFO - "repo_path": "releases/mozilla-aurora", 07:20:21 INFO - "revision": "dd939576757577e1580b84e0820f9eb2d77dd303", 07:20:21 INFO - "stage_platform": "linux64-pgo", 07:20:21 INFO - "builduid": "75d019f3c1f748868951ac2ae11eaf5e", 07:20:21 INFO - "slavebuilddir": "test" 07:20:21 INFO - } 07:20:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 07:20:21 INFO - Running post-action listener: _resource_record_post_action 07:20:21 INFO - ##### 07:20:21 INFO - ##### Finished read-buildbot-config step (success) 07:20:21 INFO - ##### 07:20:21 INFO - ##### 07:20:21 INFO - ##### Running download-and-extract step. 07:20:21 INFO - ##### 07:20:21 INFO - Running pre-action listener: _resource_record_pre_action 07:20:21 INFO - Running main action method: download_and_extract 07:20:21 INFO - mkdir: /builds/slave/test/build/tests 07:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:21 INFO - https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:20:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:20:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:20:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:21 INFO - Downloaded 1361 bytes. 07:20:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:20:21 INFO - Using the following test package requirements: 07:20:21 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:20:21 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:20:21 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:20:21 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'jsshell-linux-x86_64.zip'], 07:20:21 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:20:21 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:20:21 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:20:21 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:20:21 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:20:21 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:20:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:20:21 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:21 INFO - https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:20:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:20:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:20:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:23 INFO - Downloaded 24525302 bytes. 07:20:23 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'] 07:20:23 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 07:20:24 INFO - Return code: 0 07:20:24 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 07:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:24 INFO - https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:20:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:20:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:20:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:25 INFO - Downloaded 24525302 bytes. 07:20:25 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'] 07:20:25 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 07:20:26 INFO - Return code: 0 07:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:26 INFO - https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:27 INFO - Downloaded 10833369 bytes. 07:20:27 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'] 07:20:27 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 07:20:28 INFO - Return code: 0 07:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:28 INFO - https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc-5WG2dSmaZENcMBXUBaw/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 07:20:29 INFO - Downloaded 63642286 bytes. 07:20:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:20:29 INFO - mkdir: /builds/slave/test/properties 07:20:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:20:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:20:29 INFO - Contents: 07:20:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:20:30 INFO - Running post-action listener: _resource_record_post_action 07:20:30 INFO - Running post-action listener: set_extra_try_arguments 07:20:30 INFO - ##### 07:20:30 INFO - ##### Finished download-and-extract step (success) 07:20:30 INFO - ##### 07:20:30 INFO - ##### 07:20:30 INFO - ##### Running populate-webroot step. 07:20:30 INFO - ##### 07:20:30 INFO - Running pre-action listener: _resource_record_pre_action 07:20:30 INFO - Running main action method: populate_webroot 07:20:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:20:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:20:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:20:30 INFO - '--tppagecycles', 07:20:30 INFO - '7'], 07:20:30 INFO - 'tests': ['tsvgm']}}, 07:20:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:20:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:20:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:20:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:20:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['damp', 'tps']}, 07:20:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'tests': ['damp', 'tps']}, 07:20:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['dromaeo_dom']}, 07:20:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:20:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['a11yr', 07:20:30 INFO - 'ts_paint', 07:20:30 INFO - 'tpaint', 07:20:30 INFO - 'sessionrestore', 07:20:30 INFO - 'sessionrestore_no_auto_restore', 07:20:30 INFO - 'tabpaint']}, 07:20:30 INFO - 'other-e10s': {'tests': ['a11yr', 07:20:30 INFO - 'ts_paint', 07:20:30 INFO - 'tpaint', 07:20:30 INFO - 'sessionrestore', 07:20:30 INFO - 'sessionrestore_no_auto_restore', 07:20:30 INFO - 'tabpaint']}, 07:20:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:20:30 INFO - 'ts_paint', 07:20:30 INFO - 'tpaint', 07:20:30 INFO - 'sessionrestore', 07:20:30 INFO - 'sessionrestore_no_auto_restore', 07:20:30 INFO - 'tabpaint']}, 07:20:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:20:30 INFO - 'ts_paint', 07:20:30 INFO - 'tpaint', 07:20:30 INFO - 'sessionrestore', 07:20:30 INFO - 'sessionrestore_no_auto_restore', 07:20:30 INFO - 'tabpaint']}, 07:20:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['a11yr', 07:20:30 INFO - 'ts_paint', 07:20:30 INFO - 'tpaint', 07:20:30 INFO - 'sessionrestore', 07:20:30 INFO - 'sessionrestore_no_auto_restore', 07:20:30 INFO - 'tabpaint']}, 07:20:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['a11yr', 07:20:30 INFO - 'ts_paint', 07:20:30 INFO - 'tpaint', 07:20:30 INFO - 'sessionrestore', 07:20:30 INFO - 'sessionrestore_no_auto_restore', 07:20:30 INFO - 'tabpaint']}, 07:20:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['tsvgx', 07:20:30 INFO - 'tsvgr_opacity', 07:20:30 INFO - 'tart', 07:20:30 INFO - 'tscrollx', 07:20:30 INFO - 'cart']}, 07:20:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:20:30 INFO - 'tsvgr_opacity', 07:20:30 INFO - 'tart', 07:20:30 INFO - 'tscrollx', 07:20:30 INFO - 'cart']}, 07:20:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'talos_options': ['--disable-e10s'], 07:20:30 INFO - 'tests': ['tp5o']}, 07:20:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'tests': ['tp5o']}, 07:20:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'talos_options': ['--disable-e10s', 07:20:30 INFO - '--xperf_path', 07:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:30 INFO - 'tests': ['tp5n']}, 07:20:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:30 INFO - 'talos_options': ['--xperf_path', 07:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:30 INFO - 'tests': ['tp5n']}}, 07:20:30 INFO - 'talos.zip': {'path': '', 07:20:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:20:30 INFO - Running post-action listener: _resource_record_post_action 07:20:30 INFO - ##### 07:20:30 INFO - ##### Finished populate-webroot step (success) 07:20:30 INFO - ##### 07:20:30 INFO - ##### 07:20:30 INFO - ##### Running create-virtualenv step. 07:20:30 INFO - ##### 07:20:30 INFO - Running pre-action listener: _resource_record_pre_action 07:20:30 INFO - Running main action method: create_virtualenv 07:20:30 INFO - Creating virtualenv /builds/slave/test/build/venv 07:20:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:20:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:20:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:20:30 INFO - Using real prefix '/usr' 07:20:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:20:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:20:32 INFO - Installing pip.................done. 07:20:32 INFO - Return code: 0 07:20:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:32 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:20:32 INFO - Using env: {'DISPLAY': ':0', 07:20:32 INFO - 'HOME': '/home/cltbld', 07:20:32 INFO - 'LANG': 'en_US.UTF-8', 07:20:32 INFO - 'LANGUAGE': 'en_US:en', 07:20:32 INFO - 'LOGNAME': 'cltbld', 07:20:32 INFO - 'MAIL': '/var/mail/cltbld', 07:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:32 INFO - 'MOZ_NO_REMOTE': '1', 07:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:32 INFO - 'NO_EM_RESTART': '1', 07:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:32 INFO - 'PWD': '/builds/slave/test', 07:20:32 INFO - 'SHELL': '/bin/bash', 07:20:32 INFO - 'SHLVL': '1', 07:20:32 INFO - 'TERM': 'linux', 07:20:32 INFO - 'TMOUT': '86400', 07:20:32 INFO - 'USER': 'cltbld', 07:20:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:32 INFO - '_': '/tools/buildbot/bin/python'} 07:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:20:33 INFO - Cleaning up... 07:20:33 INFO - Return code: 0 07:20:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:20: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')]} 07:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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')]} 07:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:33 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:33 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 07:20:33 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 07:20:33 INFO - Using env: {'DISPLAY': ':0', 07:20:33 INFO - 'HOME': '/home/cltbld', 07:20:33 INFO - 'LANG': 'en_US.UTF-8', 07:20:33 INFO - 'LANGUAGE': 'en_US:en', 07:20:33 INFO - 'LOGNAME': 'cltbld', 07:20:33 INFO - 'MAIL': '/var/mail/cltbld', 07:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:33 INFO - 'MOZ_NO_REMOTE': '1', 07:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:33 INFO - 'NO_EM_RESTART': '1', 07:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:33 INFO - 'PWD': '/builds/slave/test', 07:20:33 INFO - 'SHELL': '/bin/bash', 07:20:33 INFO - 'SHLVL': '1', 07:20:33 INFO - 'TERM': 'linux', 07:20:33 INFO - 'TMOUT': '86400', 07:20:33 INFO - 'USER': 'cltbld', 07:20:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:33 INFO - '_': '/tools/buildbot/bin/python'} 07:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:33 INFO - Downloading/unpacking psutil>=3.1.1 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:20:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:35 INFO - Installing collected packages: psutil 07:20:35 INFO - Running setup.py install for psutil 07:20:35 INFO - building 'psutil._psutil_linux' extension 07:20:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:20:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:20:35 INFO - building 'psutil._psutil_posix' extension 07:20:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:20:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:20:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:35 INFO - Successfully installed psutil 07:20:35 INFO - Cleaning up... 07:20:35 INFO - Return code: 0 07:20:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:35 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:35 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 07:20:35 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 07:20:35 INFO - Using env: {'DISPLAY': ':0', 07:20:35 INFO - 'HOME': '/home/cltbld', 07:20:35 INFO - 'LANG': 'en_US.UTF-8', 07:20:35 INFO - 'LANGUAGE': 'en_US:en', 07:20:35 INFO - 'LOGNAME': 'cltbld', 07:20:35 INFO - 'MAIL': '/var/mail/cltbld', 07:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:35 INFO - 'MOZ_NO_REMOTE': '1', 07:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:35 INFO - 'NO_EM_RESTART': '1', 07:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:35 INFO - 'PWD': '/builds/slave/test', 07:20:35 INFO - 'SHELL': '/bin/bash', 07:20:35 INFO - 'SHLVL': '1', 07:20:35 INFO - 'TERM': 'linux', 07:20:35 INFO - 'TMOUT': '86400', 07:20:35 INFO - 'USER': 'cltbld', 07:20:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:35 INFO - '_': '/tools/buildbot/bin/python'} 07:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:20:37 INFO - Installing collected packages: mozsystemmonitor 07:20:37 INFO - Running setup.py install for mozsystemmonitor 07:20:38 INFO - Successfully installed mozsystemmonitor 07:20:38 INFO - Cleaning up... 07:20:38 INFO - Return code: 0 07:20:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:38 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:38 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 07:20:38 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 07:20:38 INFO - Using env: {'DISPLAY': ':0', 07:20:38 INFO - 'HOME': '/home/cltbld', 07:20:38 INFO - 'LANG': 'en_US.UTF-8', 07:20:38 INFO - 'LANGUAGE': 'en_US:en', 07:20:38 INFO - 'LOGNAME': 'cltbld', 07:20:38 INFO - 'MAIL': '/var/mail/cltbld', 07:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:38 INFO - 'MOZ_NO_REMOTE': '1', 07:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:38 INFO - 'NO_EM_RESTART': '1', 07:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:38 INFO - 'PWD': '/builds/slave/test', 07:20:38 INFO - 'SHELL': '/bin/bash', 07:20:38 INFO - 'SHLVL': '1', 07:20:38 INFO - 'TERM': 'linux', 07:20:38 INFO - 'TMOUT': '86400', 07:20:38 INFO - 'USER': 'cltbld', 07:20:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:38 INFO - '_': '/tools/buildbot/bin/python'} 07:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:38 INFO - Downloading/unpacking jsonschema==2.5.1 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:20:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:40 INFO - Downloading functools32-3.2.3-2.tar.gz 07:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:20:40 INFO - warning: no files found matching '*.txt' 07:20:40 INFO - no previously-included directories found matching 'build' 07:20:40 INFO - no previously-included directories found matching 'dist' 07:20:40 INFO - no previously-included directories found matching '.git*' 07:20:40 INFO - Installing collected packages: jsonschema, functools32 07:20:40 INFO - Running setup.py install for functools32 07:20:40 INFO - warning: no files found matching '*.txt' 07:20:40 INFO - no previously-included directories found matching 'build' 07:20:40 INFO - no previously-included directories found matching 'dist' 07:20:40 INFO - no previously-included directories found matching '.git*' 07:20:40 INFO - Successfully installed jsonschema functools32 07:20:40 INFO - Cleaning up... 07:20:40 INFO - Return code: 0 07:20:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:40 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:20:40 INFO - Using env: {'DISPLAY': ':0', 07:20:40 INFO - 'HOME': '/home/cltbld', 07:20:40 INFO - 'LANG': 'en_US.UTF-8', 07:20:40 INFO - 'LANGUAGE': 'en_US:en', 07:20:40 INFO - 'LOGNAME': 'cltbld', 07:20:40 INFO - 'MAIL': '/var/mail/cltbld', 07:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:40 INFO - 'MOZ_NO_REMOTE': '1', 07:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:40 INFO - 'NO_EM_RESTART': '1', 07:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:40 INFO - 'PWD': '/builds/slave/test', 07:20:40 INFO - 'SHELL': '/bin/bash', 07:20:40 INFO - 'SHLVL': '1', 07:20:40 INFO - 'TERM': 'linux', 07:20:40 INFO - 'TMOUT': '86400', 07:20:40 INFO - 'USER': 'cltbld', 07:20:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:40 INFO - '_': '/tools/buildbot/bin/python'} 07:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:41 INFO - Downloading/unpacking blobuploader==1.2.4 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:20:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:20:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20:43 INFO - Downloading docopt-0.6.1.tar.gz 07:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:20:43 INFO - Installing collected packages: blobuploader, requests, docopt 07:20:43 INFO - Running setup.py install for blobuploader 07:20:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:20:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:20:43 INFO - Running setup.py install for requests 07:20:44 INFO - Running setup.py install for docopt 07:20:44 INFO - Successfully installed blobuploader requests docopt 07:20:44 INFO - Cleaning up... 07:20:44 INFO - Return code: 0 07:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:44 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:20:44 INFO - Using env: {'DISPLAY': ':0', 07:20:44 INFO - 'HOME': '/home/cltbld', 07:20:44 INFO - 'LANG': 'en_US.UTF-8', 07:20:44 INFO - 'LANGUAGE': 'en_US:en', 07:20:44 INFO - 'LOGNAME': 'cltbld', 07:20:44 INFO - 'MAIL': '/var/mail/cltbld', 07:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:44 INFO - 'MOZ_NO_REMOTE': '1', 07:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:44 INFO - 'NO_EM_RESTART': '1', 07:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:44 INFO - 'PWD': '/builds/slave/test', 07:20:44 INFO - 'SHELL': '/bin/bash', 07:20:44 INFO - 'SHLVL': '1', 07:20:44 INFO - 'TERM': 'linux', 07:20:44 INFO - 'TMOUT': '86400', 07:20:44 INFO - 'USER': 'cltbld', 07:20:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:44 INFO - '_': '/tools/buildbot/bin/python'} 07:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:20:44 INFO - Running setup.py (path:/tmp/pip-yYbZNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:20:44 INFO - Running setup.py (path:/tmp/pip-OO74UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:20:44 INFO - Running setup.py (path:/tmp/pip-PWJ4Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:20:44 INFO - Running setup.py (path:/tmp/pip-FVVz5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:20:44 INFO - Running setup.py (path:/tmp/pip-qsENxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:20:45 INFO - Running setup.py (path:/tmp/pip-s6idhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:20:45 INFO - Running setup.py (path:/tmp/pip-CL7ljU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:20:45 INFO - Running setup.py (path:/tmp/pip-Xyj7ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:20:45 INFO - Running setup.py (path:/tmp/pip-2hRP9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:20:45 INFO - Running setup.py (path:/tmp/pip-ASUumX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:20:45 INFO - Running setup.py (path:/tmp/pip-WFRAOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:20:45 INFO - Running setup.py (path:/tmp/pip-sVkgSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:20:45 INFO - Running setup.py (path:/tmp/pip-q4T5sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:20:45 INFO - Running setup.py (path:/tmp/pip-B9KTrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:45 INFO - Running setup.py (path:/tmp/pip-sQn1hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:20:45 INFO - Running setup.py (path:/tmp/pip-6gHsa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:20:45 INFO - Running setup.py (path:/tmp/pip-LCG2S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:20:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:20:45 INFO - Running setup.py install for manifestparser 07:20:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:20:45 INFO - Running setup.py install for mozcrash 07:20:46 INFO - Running setup.py install for mozdebug 07:20:46 INFO - Running setup.py install for mozdevice 07:20:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Running setup.py install for mozfile 07:20:46 INFO - Running setup.py install for mozhttpd 07:20:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Running setup.py install for mozinfo 07:20:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Running setup.py install for mozInstall 07:20:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Running setup.py install for mozleak 07:20:46 INFO - Running setup.py install for mozlog 07:20:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:20:46 INFO - Running setup.py install for moznetwork 07:20:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:20:47 INFO - Running setup.py install for mozprocess 07:20:47 INFO - Running setup.py install for mozprofile 07:20:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:20:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:20:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:20:47 INFO - Running setup.py install for mozrunner 07:20:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:20:47 INFO - Running setup.py install for mozscreenshot 07:20:47 INFO - Running setup.py install for moztest 07:20:47 INFO - Running setup.py install for mozversion 07:20:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:20:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:20:47 INFO - Cleaning up... 07:20:47 INFO - Return code: 0 07:20:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:47 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:20:47 INFO - Using env: {'DISPLAY': ':0', 07:20:47 INFO - 'HOME': '/home/cltbld', 07:20:47 INFO - 'LANG': 'en_US.UTF-8', 07:20:47 INFO - 'LANGUAGE': 'en_US:en', 07:20:47 INFO - 'LOGNAME': 'cltbld', 07:20:47 INFO - 'MAIL': '/var/mail/cltbld', 07:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:47 INFO - 'MOZ_NO_REMOTE': '1', 07:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:47 INFO - 'NO_EM_RESTART': '1', 07:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:47 INFO - 'PWD': '/builds/slave/test', 07:20:47 INFO - 'SHELL': '/bin/bash', 07:20:47 INFO - 'SHLVL': '1', 07:20:47 INFO - 'TERM': 'linux', 07:20:47 INFO - 'TMOUT': '86400', 07:20:47 INFO - 'USER': 'cltbld', 07:20:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:47 INFO - '_': '/tools/buildbot/bin/python'} 07:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:20:47 INFO - Running setup.py (path:/tmp/pip-KOjVTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:20:47 INFO - Running setup.py (path:/tmp/pip-PbkZS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:20:48 INFO - Running setup.py (path:/tmp/pip-YumxqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:20:48 INFO - Running setup.py (path:/tmp/pip-2diuNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:20:48 INFO - Running setup.py (path:/tmp/pip-5ptk46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:20:48 INFO - Running setup.py (path:/tmp/pip-rDXKZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:20:48 INFO - Running setup.py (path:/tmp/pip-3xeW_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:20:48 INFO - Running setup.py (path:/tmp/pip-DqFE0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:20:48 INFO - Running setup.py (path:/tmp/pip-UwgkAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:20:48 INFO - Running setup.py (path:/tmp/pip-qXil12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:20:48 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)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:20:48 INFO - Running setup.py (path:/tmp/pip-_nt4Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:20:48 INFO - Running setup.py (path:/tmp/pip-s__FQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:20:48 INFO - Running setup.py (path:/tmp/pip-GLqODW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:20:48 INFO - Running setup.py (path:/tmp/pip-DuySo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:48 INFO - Running setup.py (path:/tmp/pip-9v_ypZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:20:48 INFO - Running setup.py (path:/tmp/pip-HaA7kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:20:49 INFO - Running setup.py (path:/tmp/pip-KnRMWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:20:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:51 INFO - Downloading blessings-1.6.tar.gz 07:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:20:51 INFO - Installing collected packages: blessings 07:20:51 INFO - Running setup.py install for blessings 07:20:51 INFO - Successfully installed blessings 07:20:51 INFO - Cleaning up... 07:20:51 INFO - Return code: 0 07:20:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:51 INFO - Reading from file tmpfile_stdout 07:20:51 INFO - Current package versions: 07:20:51 INFO - argparse == 1.2.1 07:20:51 INFO - blessings == 1.6 07:20:51 INFO - blobuploader == 1.2.4 07:20:51 INFO - docopt == 0.6.1 07:20:51 INFO - functools32 == 3.2.3-2 07:20:51 INFO - jsonschema == 2.5.1 07:20:51 INFO - manifestparser == 1.1 07:20:51 INFO - mozInstall == 1.12 07:20:51 INFO - mozcrash == 0.17 07:20:51 INFO - mozdebug == 0.1 07:20:51 INFO - mozdevice == 0.48 07:20:51 INFO - mozfile == 1.2 07:20:51 INFO - mozhttpd == 0.7 07:20:51 INFO - mozinfo == 0.9 07:20:51 INFO - mozleak == 0.1 07:20:51 INFO - mozlog == 3.2 07:20:51 INFO - moznetwork == 0.27 07:20:51 INFO - mozprocess == 0.22 07:20:51 INFO - mozprofile == 0.28 07:20:51 INFO - mozrunner == 6.11 07:20:51 INFO - mozscreenshot == 0.1 07:20:51 INFO - mozsystemmonitor == 0.3 07:20:51 INFO - moztest == 0.7 07:20:51 INFO - mozversion == 1.4 07:20:51 INFO - psutil == 3.1.1 07:20:51 INFO - requests == 1.2.3 07:20:51 INFO - wsgiref == 0.1.2 07:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:51 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 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:20:51 INFO - Using env: {'DISPLAY': ':0', 07:20:51 INFO - 'HOME': '/home/cltbld', 07:20:51 INFO - 'LANG': 'en_US.UTF-8', 07:20:51 INFO - 'LANGUAGE': 'en_US:en', 07:20:51 INFO - 'LOGNAME': 'cltbld', 07:20:51 INFO - 'MAIL': '/var/mail/cltbld', 07:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:51 INFO - 'MOZ_NO_REMOTE': '1', 07:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:51 INFO - 'NO_EM_RESTART': '1', 07:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:51 INFO - 'PWD': '/builds/slave/test', 07:20:51 INFO - 'SHELL': '/bin/bash', 07:20:51 INFO - 'SHLVL': '1', 07:20:51 INFO - 'TERM': 'linux', 07:20:51 INFO - 'TMOUT': '86400', 07:20:51 INFO - 'USER': 'cltbld', 07:20:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:51 INFO - '_': '/tools/buildbot/bin/python'} 07:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:20:51 INFO - Cleaning up... 07:20:51 INFO - Return code: 0 07:20:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:20:51 INFO - Using env: {'DISPLAY': ':0', 07:20:51 INFO - 'HOME': '/home/cltbld', 07:20:51 INFO - 'LANG': 'en_US.UTF-8', 07:20:51 INFO - 'LANGUAGE': 'en_US:en', 07:20:51 INFO - 'LOGNAME': 'cltbld', 07:20:51 INFO - 'MAIL': '/var/mail/cltbld', 07:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:51 INFO - 'MOZ_NO_REMOTE': '1', 07:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:51 INFO - 'NO_EM_RESTART': '1', 07:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:51 INFO - 'PWD': '/builds/slave/test', 07:20:51 INFO - 'SHELL': '/bin/bash', 07:20:51 INFO - 'SHLVL': '1', 07:20:51 INFO - 'TERM': 'linux', 07:20:51 INFO - 'TMOUT': '86400', 07:20:51 INFO - 'USER': 'cltbld', 07:20:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:51 INFO - '_': '/tools/buildbot/bin/python'} 07:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:20:51 INFO - Cleaning up... 07:20:51 INFO - Return code: 0 07:20:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e6718bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:20:51 INFO - Using env: {'DISPLAY': ':0', 07:20:51 INFO - 'HOME': '/home/cltbld', 07:20:51 INFO - 'LANG': 'en_US.UTF-8', 07:20:51 INFO - 'LANGUAGE': 'en_US:en', 07:20:51 INFO - 'LOGNAME': 'cltbld', 07:20:51 INFO - 'MAIL': '/var/mail/cltbld', 07:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:51 INFO - 'MOZ_NO_REMOTE': '1', 07:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:51 INFO - 'NO_EM_RESTART': '1', 07:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:51 INFO - 'PWD': '/builds/slave/test', 07:20:51 INFO - 'SHELL': '/bin/bash', 07:20:51 INFO - 'SHLVL': '1', 07:20:51 INFO - 'TERM': 'linux', 07:20:51 INFO - 'TMOUT': '86400', 07:20:51 INFO - 'USER': 'cltbld', 07:20:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:51 INFO - '_': '/tools/buildbot/bin/python'} 07:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:52 INFO - Downloading/unpacking flake8 07:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:20:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:20:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:20:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:20:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:20:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:20:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:20:54 INFO - no previously-included directories found matching 'docs/_build' 07:20:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:20:54 INFO - Running setup.py install for pep8 07:20:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:20:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:20:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:20:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:20:54 INFO - no previously-included directories found matching 'docs/_build' 07:20:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:20:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:20:54 INFO - Cleaning up... 07:20:55 INFO - Return code: 0 07:20:55 INFO - Running post-action listener: _resource_record_post_action 07:20:55 INFO - Running post-action listener: _start_resource_monitoring 07:20:55 INFO - Starting resource monitoring. 07:20:55 INFO - ##### 07:20:55 INFO - ##### Finished create-virtualenv step (success) 07:20:55 INFO - ##### 07:20:55 INFO - ##### 07:20:55 INFO - ##### Running install step. 07:20:55 INFO - ##### 07:20:55 INFO - Running pre-action listener: _resource_record_pre_action 07:20:55 INFO - Running main action method: install 07:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:55 INFO - Reading from file tmpfile_stdout 07:20:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:20:55 INFO - Reading from file tmpfile_stdout 07:20:55 INFO - Output received: 07:20:55 INFO - Usage: mozinstall [options] installer 07:20:55 INFO - Options: 07:20:55 INFO - -h, --help show this help message and exit 07:20:55 INFO - -d DEST, --destination=DEST 07:20:55 INFO - Directory to install application into. [default: 07:20:55 INFO - "/builds/slave/test"] 07:20:55 INFO - --app=APP Application being installed. [default: firefox] 07:20:55 INFO - mkdir: /builds/slave/test/build/application 07:20:55 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'] 07:20:55 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 07:21:11 INFO - Reading from file tmpfile_stdout 07:21:11 INFO - Output received: 07:21:11 INFO - /builds/slave/test/build/application/firefox/firefox 07:21:11 INFO - Running post-action listener: _resource_record_post_action 07:21:11 INFO - ##### 07:21:11 INFO - ##### Finished install step (success) 07:21:11 INFO - ##### 07:21:11 INFO - ##### 07:21:11 INFO - ##### Running run-tests step. 07:21:11 INFO - ##### 07:21:11 INFO - Running pre-action listener: _resource_record_pre_action 07:21:11 INFO - Running main action method: run_tests 07:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:21:11 INFO - Python 2.7.3 07:21:11 INFO - Return code: 0 07:21:11 INFO - grabbing minidump binary from tooltool 07:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:11 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 0x29bd1c0>, '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 0x29be0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:21:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:21:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:21:11 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 07:21:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:21:11 INFO - Return code: 0 07:21:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:21:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:21:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:21:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:21:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:21:12 INFO - Return code: 0 07:21:12 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:21:12 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:21:12 INFO - Using env: {'DISPLAY': ':0', 07:21:12 INFO - 'HOME': '/home/cltbld', 07:21:12 INFO - 'LANG': 'en_US.UTF-8', 07:21:12 INFO - 'LANGUAGE': 'en_US:en', 07:21:12 INFO - 'LOGNAME': 'cltbld', 07:21:12 INFO - 'MAIL': '/var/mail/cltbld', 07:21:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:21:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:12 INFO - 'MOZ_NO_REMOTE': '1', 07:21:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:12 INFO - 'NO_EM_RESTART': '1', 07:21:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:12 INFO - 'PWD': '/builds/slave/test', 07:21:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:21:12 INFO - 'SHELL': '/bin/bash', 07:21:12 INFO - 'SHLVL': '1', 07:21:12 INFO - 'TERM': 'linux', 07:21:12 INFO - 'TMOUT': '86400', 07:21:12 INFO - 'USER': 'cltbld', 07:21:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281', 07:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:12 INFO - '_': '/tools/buildbot/bin/python'} 07:21:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:21:12 INFO - mozversion application_buildid: 20160708040825 07:21:12 INFO - mozversion application_changeset: dd939576757577e1580b84e0820f9eb2d77dd303 07:21:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:21:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:21:12 INFO - mozversion application_name: Firefox 07:21:12 INFO - mozversion application_remotingname: firefox-dev 07:21:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:21:12 INFO - mozversion application_vendor: Mozilla 07:21:12 INFO - mozversion application_version: 49.0a2 07:21:12 INFO - mozversion platform_buildid: 20160708040825 07:21:12 INFO - mozversion platform_changeset: dd939576757577e1580b84e0820f9eb2d77dd303 07:21:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:21:12 INFO - mozversion platform_version: 49.0a2 07:21:12 INFO - using testdate: 1467987672 07:21:12 INFO - actual date: 1467987672 07:21:12 INFO - starting webserver on 'localhost:34876' 07:21:12 INFO - SUITE-START | Running 2 tests 07:21:12 INFO - TEST-START | dromaeo_css 07:21:12 INFO - operating with platform_type : linux_ 07:21:12 INFO - Initialising browser for dromaeo_css test... 07:21:12 INFO - TEST-INFO | started process 14716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcq8hEG/profile http://localhost:34876/getInfo.html) 07:21:16 INFO - PROCESS | 14716 | __metrics Screen width/height:1600/1200 07:21:16 INFO - PROCESS | 14716 | colorDepth:24 07:21:16 INFO - PROCESS | 14716 | Browser inner width/height: 1024/697 07:21:16 INFO - PROCESS | 14716 | __metrics 07:21:16 ERROR - PROCESS | 14716 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:21:17 INFO - TEST-INFO | 14716: exit 0 07:21:17 INFO - Browser initialized. 07:21:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:21:17 INFO - TEST-INFO | started process 14847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcq8hEG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:29 INFO - PROCESS | 14847 | RSS: Main: 156049408 07:21:29 INFO - PROCESS | 14847 | 07:22:19 INFO - PROCESS | 14847 | 1467987739004 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:24:26 INFO - PROCESS | 14847 | Cycle 1(1): loaded http://localhost:34876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34876/tests/dromaeo/cssquery-ext.html) 07:24:28 INFO - PROCESS | 14847 | RSS: Main: 159371264 07:24:28 INFO - PROCESS | 14847 | 07:27:30 INFO - PROCESS | 14847 | Cycle 1(1): loaded http://localhost:34876/tests/dromaeo/cssquery-ext.html (next: http://localhost:34876/tests/dromaeo/cssquery-jquery.html) 07:27:30 INFO - PROCESS | 14847 | RSS: Main: 158072832 07:27:30 INFO - PROCESS | 14847 | 07:30:32 INFO - PROCESS | 14847 | Cycle 1(1): loaded http://localhost:34876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34876/tests/dromaeo/cssquery-mootools.html) 07:30:32 INFO - PROCESS | 14847 | RSS: Main: 156975104 07:30:32 INFO - PROCESS | 14847 | 07:33:34 INFO - PROCESS | 14847 | Cycle 1(1): loaded http://localhost:34876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34876/tests/dromaeo/cssquery-prototype.html) 07:33:35 INFO - PROCESS | 14847 | RSS: Main: 156368896 07:33:35 INFO - PROCESS | 14847 | 07:36:37 INFO - PROCESS | 14847 | Cycle 1(1): loaded http://localhost:34876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34876/tests/dromaeo/cssquery-yui.html) 07:36:38 INFO - PROCESS | 14847 | RSS: Main: 158216192 07:36:38 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | Cycle 1(1): loaded http://localhost:34876/tests/dromaeo/cssquery-yui.html (next: http://localhost:34876/tests/dromaeo/cssquery-dojo.html) 07:39:40 INFO - PROCESS | 14847 | RSS: Main: 159498240 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | __start_tp_report 07:39:40 INFO - PROCESS | 14847 | _x_x_mozilla_page_load 07:39:40 INFO - PROCESS | 14847 | _x_x_mozilla_page_load_details 07:39:40 INFO - PROCESS | 14847 | |i|pagename|runs| 07:39:40 INFO - PROCESS | 14847 | |0;dojo.html;3309.090000249931;3348.26338205595;3367.9663203367973;3377.5440315557394;3395.286989732156;5589.972050139749;5601.4958653721205;5626.578006649503;5637;5686.943130568693;5610.579206559504;5670.064439367509;5678.858028549288;5712.028955077636;5719.799807006755;5078.74606269686;5143.974280128594;5171.120909445384;5198.220266959967;5210.557102646279;5043.319151914481;5072.594192464594;5214.452482489341;5220;5220.817271395502;5153.1754919212935;5165.948340516585;5167.664101833388;5168.405633352157;5211.687298762067;5121.28302037715;5128.8974220515565;5212.270282160501;5219;5221.738913054332;5029.3964724232965;5064.392272927235;5143.3313669223135;5158.69047857126;5173.586113110942;5404.486573775485;5481.314835645544;5487.204355368449;5561.694106824123;5569;6029.698515074228;6071.51427885768;6072.453479186895;6083.726232319556;6090.786822461193;5821.27234095738;6148.754049838001;6153.753849846001;6160.322364539897;6163.137160797492;5616.634918730269;5632.014397480466;5642.802501912413;5648.491635752802;5681.488666020078;6131.96934015336;6154.661493617805;6165.32181460039;6173.166622505994;6194.5044396448175;5723.627964182315;5804.593678442553;5870.207521984563;5886.911696324559;5888.911666325009;5936.584439089309;5995.970020149872;6005.099235114768;6028.788992385245;6072.574919755663;5951.404859514014;5982.700864956735;5993.61041532299;6011.939880601226;6040.939590604038;5865.472107510344;5895.204147440127;5903.35063143054;6060.575759696867;6062.302835174011;4597.655175861823;4610.95389046112;4615.699979501322;4624.5144259852905;4627.097715945426;4132.318167502329;4135.17296540693;4142.502899652;4144.79276036203;4176.644985176234;5746.396628353963;5782.508486778587;5796;5809.244798176294;5832.387599302012;5926.111083337534;5933.317668468181;5981.252343457068;6023.789167379121;6100;5789.797357092481;5821.621594596338;5821.679807610537;5822.33043200029;5824.737886795019;5050.267711181858;5115.18157094863;5147.922781158286;5162.328897243409;5203.947960520422;6311.33730958252;6322.71547780351;6334.619922804646;6340.207474065742;6341.143945567289;5836.562257830765;6123.877522449615;6125.326214116443;6127.080937859357;6135.7238924249405;6224.533160012927;6236.937630623635;6290.591111577733;6387.936120638734;6392.360763923756;5983;5983.162357270073;5990.550708696952;6002.789902353396;6030.185924900258;5880.206172166702;6021.277446706424;6129.172561704113;6143.754249829957;6145.262568491809;5908.970455147697;6003.879922401615;6004.759809607742;6005.489533389711;6026.15633811258;5865.706714664335;5914.970425147847;5976.641401515749;5982.52139828804;5988.970055149696;5688.288963879515;5722.942770572241;5748.367679555329;5840.415958404125;5887.7056147191615;5860.912086318794;5950.98833198366;5974.22335096452;6002.579819412599;6006.669633170218;5808.041673124057;5832.358440571449;5859.94140058594;5869.530437564899;5879.470847623564 07:39:40 INFO - PROCESS | 14847 | |1;ext.html;599.226997173646;638.9265234498034;656.464981040452;667.2693400726206;672.7678950761987;35553.82223088884;38907;47498.050038999245;48494.75752621232;48607;49199.75400122994;49277.75361123189;49316;49645;49685.75157124218;9022.233110185625;9105.36262461628;9123.68067117651;9147.679831205909;9164.129407706258;8931.866022009675;8946.910530894673;8993.100689930987;9017.864732029026;9034.27725781939;9092.318076144282;9120.224780893632;9123.726288211332;9131.817363652723;9139;9002.459852408843;9020.909790902106;9050.909490905105;9060.365774395796;9078.546072696405;9036.50299233542;9053.954730226307;9082.273418126533;9144.908550914472;9152.31357648179;45297.32054019159;45980;45999;46012.76993615044;46081.769591152166;3678.742488025839;4170.624643782075;4297.5272720001085;4302;4490.865274041784;34253.6574634253;34320;34703.6529634703;35981.640183598094;36216.63783362159;4630;4763.69036012658;4810.759462026885;4817.590504807095;4895.265710143472;383393;384092;389517;389680;392137;35910.640893591255;36682.63317366792;36697.08257293589;64891;65503.67248163824;39657;39728;39736.20527589432;39811;39828.20343593112;15818.9209053954;15957.840421595867;15959.202039897958;16005.199740012953;16044.197790110447;13486.12340197884;13538.729225415436;13546.729065418636;13560.660983475493;13568.321583920764;9202.63189472427;9271.629134834531;9271.629134834666;9282.675106371245;9343.953280233556;3482.21650128719;3528.7353448491467;3541.451075083366;3572.2319701264355;3609.873654422135;1100.2628239079836;1187.9821802672966;1188.5483516263937;1189.9409525522292;1244.1539752967888;34211;34329.82835085859;34735.13162170966;35471.4679279811;37659.623403766156;1090.6946055104584;1203.602811072344;1251.993740031294;1257.9811302830465;1267.1889990406148;17626.471205863843;17651.470455886087;17848.821511784976;17850.19674114642;17896.9105154476;549996;556575;588473;974509;986812;61260;62036;62135.37864621296;62171;62352.376476234655;1475.6605980624518;1487.196913666608;1500.2348802111003;1517.7950976618015;1522.0411140981112;31817.5227371585;31935.201619959687;32868.178295542806;33129.66870331266;33177.83411082929;53787;54247;54335;54492;54537.181942271694;409130;411726;413937;415846;416828;29913.401731965674;30385.696143038287;30558;31191.688083119785;31831.84084079565;51921.48078519166;52609.210861836335;53246.73376633092;53332.46667533275;54157.72921135369;44286.335704965095;44463.77768111139;44624;44649.10701786011;45751;43047.35428968631;44256;45492.54507455016;46015;46220.76889615531;45476.77261613671;45546.772266138454;46022.079558407975;46279;46319.84200395017;38196.80901595474;38295.6170438292;38334.80832595819;39432.40851387174;39703.60296397115;30375.848120759256;31031.379372412877;31071.223219419695;31293.687063129077;31589.210269743442 07:39:40 INFO - PROCESS | 14847 | |2;jquery.html;430.2814300118802;432.8658115984043;434.52092599932473;435.11888425937474;437.5274703320412;18241.179146938386;19107.3312434065;19784;20493.38519844407;20544.79455205451;19339.323123690672;19469;19622.509437264074;20381.796182038175;20384.69422958653;5143.614228932826;5259.737013149346;5297.973510132444;5316.494932981361;5318;5745.994450971084;5894.705264736767;5933.525317974551;5951.196588460546;5952;5856.970715146418;5884.352721200665;5888.793892213774;5897.4692277695;5904.7047647617665;5620.4098569650005;5800.651960882361;5847.239858818348;5865.442782935615;5867.970660146715;5251.842444726664;5256.763445644917;5272.209168624737;5309.946900531023;5314.73426328682;22774.544509109724;23733.7626623735;24104.879475602684;24389;24422;2652.3103992961774;2759.8206116602355;2930.868110935013;2930.8827646894097;3163.7785355025158;14563.635909102251;15005.69988600222;15130.924345378202;15243.466478673194;15573.065616063073;1868.8037756035556;1887.8017808130223;1891.8391936685398;1947.4157752674141;2043.7751847296786;77495.22504774993;83553;88507;89258;96393.5180324101;10413.114885234689;11193.272437291713;11642.88357116435;11718;11792.823107653221;16394.26225819841;16552.586185345222;16557.089360085312;16583.585410364594;16678;8685.739427817176;9010.774730631656;9075.863862042075;9128.58921348541;9249.815003700023;8821.338399620054;8895.688650897187;8898;8962.68630597926;9027.097290271051;4424;4545.5908968193025;4658.883527911761;4667.393238878924;5084.542391184811;1968.517713160285;2067.917283308651;2076.2940600196007;2098.7166732491223;2135.4661334666334;957.6408846682494;989.6536212325628;1014.6803756816579;1057.4078516031047;1090.547422819537;18713;19417.902910485638;19553.413397598095;19933.60132797365;20033.59932801336;1049.4123290956936;1050.1179009631794;1054.9578016879238;1071.137734124022;1138.4364739454024;11172.888271117185;11421.257618254787;11557.07543396543;11557.653270401901;11588.13089018327;360221;362829;362967;512647;513317;76965.74843608186;97406.51296743471;100191;105937;107013;1089.803835309636;1104.812181929074;1116.3302018788825;1134.013408334754;1134.7219931116765;18493.260269589606;18596.535086622942;18741.34405295808;18828.435146945612;19006.524836879187;42286.942826429586;43174.568254317055;43769;44060.779696101315;45357.77321113373;60689.39310607014;60998;61756.38243617507;61773;63168.052479213766;8284.668613255402;8577.31381489467;8662.956685216786;8777.078406767198;8837.602307896288;12519;13442.731145376842;13666.794998074838;13861.4455421782;14130.364133613806;12118.818217726564;12203.938980305042;12288.324142172267;12469.251844889335;12613;11598.130140239347;11793.351365674971;11813.11401644863;11940.761184776082;12012.219205751948;12352.135350525736;12353.3823308836;12366.567170149001;12751.61745147647;13169.934150329187;8491.617877195664;8579.528125953133;8591.914080859111;8716.694915677921;8989.46063236208;11115.277506962022;11646.417679116179;11701.707457313636;11717.296962182296;11794.587189448328 07:39:40 INFO - PROCESS | 14847 | |3;mootools.html;1538.8768898488122;1579.447193482281;1762.7267773495112;1889.1309997401204;1909.7135429685554;8367.707130250443;8805.779855503608;8988.415752976052;9350.298727595433;9444.622215111396;8952;9266.119718626736;9305.162535371815;9388.530573471333;9396.38923469974;2441.1578005588044;2470.17249221511;2474.084588702183;2483.50329934013;2494.077191439161;2392.473655795722;2498.150628786212;2504.474060447308;2507.247825652297;2507.448361360498;2434.6834911461483;2436.11081955086;2436.683231179953;2450.0567281596623;2465.3713303107684;2382.1424287256573;2415.4565222824813;2416.516696660666;2442.218490083174;2447.5349683560066;2380.666706661069;2397.748236435184;2426.696662917135;2430.6597076409316;2440.7803297703113;9284.25725941923;9433.622655093788;9461.432314061109;9497.572609232531;9506.239500839916;5586.748596313135;5750.6262092963825;5762.74067666956;5764.250647415809;5766.855828604276;3520.3487354839435;3545.840437180307;3639.981800091009;3663.5786884508357;3731.570869350005;1131.242067814558;1170.034721354877;1178.4225729392622;1180.4687890449331;1188.7622475504847;13381.866181338257;13425.194488330731;13455.259960702157;13521.932390337985;13538.661533461545;4731.827005508304;4813.15769740294;4860.854174374775;4887;4922.483139270396;11243.437828108561;11282.661520154408;11321.660350189508;11333.659990200307;11338.829917551244;5609.158626206102;5701.458361455655;5725.141228815711;5732.484076433141;5738.856528586819;4644.535546445396;5095;5269.499397557226;5272.657277276965;5320.920186197211;4232.407462955189;4266.381374700713;4305.590968857953;4353.477582690034;4384.364267181305;1305.0603565432873;1319;1339.1964821107451;1339.4909934224931;1359.34071975092;973.4013581647235;1053.4837929414532;1070.0957690751302;1091.7434402915308;1117.391021893054;6449.709763060673;6562.80311590653;6572.277049524549;6580.243272023683;6632;461.5684335146649;486.66906503577906;1092.2408925796494;1165.347405452949;1170.9824352634716;4208.452901122896;4218.8312467500955;4274.7435153890865;4327.870163895088;4336.371226172188;11841.822372664417;12087.516499340103;12093.637190884112;12132.5146994121;12177.269363838199;11666.941665291619;12005.159638825373;12029.518819247307;12125.211861228992;12172.81740773889;8850.20348168655;8867.512286824158;8898.822023559493;8964.641414343354;8965;6520.902186467112;6552.705128269144;6578.8355291118105;6593.538452308292;6615.37153970372;10904.836427453436;11093.722656933642;11132.888671113185;11154.776904462027;11186.608468703556;11026.558937642725;11148.386838723947;11249.100071994057;11336.716582085513;11339.206255562032;7194.640267986475;8059.1134975153855;8147.79630509242;8721.433106848035;9111.088891110836;8879.644814207359;9144.131307525775;9176;9225;9238.491882946502;8280.958595206985;8475;8492.74521764348;8510.872336914827;8519.701810436605;8213.671453141807;8219.301359384519;8324.375671824759;8399.70601028961;8423.326133909395;6880.2431732508385;6885.483588730765;6894.310568943066;6895.172579290517;7116.217216106328;5399.325084364455;5456.263404440349;5564.888702226014;5685.289338832646;5816.41835816415;5491.423400543045;5534.557235421076;5598.160275958476;5608.831735047955;5695.971520142372 07:39:40 INFO - PROCESS | 14847 | |4;prototype.html;316.96037995250595;326.72391828904574;327.4515187061672;327.75254682714547;329.73785840257005;5506.311711036121;5611.270534830476;5615.971920140399;5713.342965558962;5741.282339707536;5594.272744543214;5622.606417550773;5641.887162256763;5649.830505084844;5667.149927510875;4389.341598760179;4404.735715857043;4409.096135292258;4419.845305414311;4421.911561768763;4247.362895565674;4427.867163985085;4441.689081764278;4442.222611043071;4442.689011769177;4345.718013186102;4379.146066517031;4392.758398288093;4402.295632698769;4409.669274804386;4376.452943382062;4430.113977204556;4438.911221775546;4446.088182081704;4462.3752674625575;3787.7088846692386;3879.321118804226;3910.7513179921657;3917.764934103963;3923.7645741255333;5463.863403414906;5471.37079235889;5494.972525137388;5513.448655134494;5518.889622207534;5023.748812559394;5040.092783299005;5050.494950504957;5054.7472626368535;5059.747012649353;5745.798897038625;5938.228030356069;5969;5981.8803623927715;5984.743203927181;4236.724612900151;4253.659707223414;4255.787210639455;4271.124419493996;4287.571242875719;6203.0075187969705;6203.534734894856;6235.781747638811;6239.2824825145235;6253.249610046778;4266.488021437447;4324.805383757738;4357.520672725997;4357.586029327209;4360.127974405132;4315.136972605492;4376.868693939124;4407.515173330931;4411.647068234533;4417.293233082692;5016.774245158977;5032.6980381177245;5039.102516053211;5043.9747801260755;5056.092746670605;5897.675627840425;5944.464998150187;5991.880162396727;6035.969820150871;6058.666773327509;1493.11905975475;1515.909045457276;1527.2211172302207;1527.3356090100842;1530.8469153084602;947.6777895515557;963.5471328475745;966.2994329111478;969.4328817641617;981.1562056631292;5153.871153221199;5159.716215608178;5177.58579313654;5189.6886186828915;5238.947610523922;5422.3764267109;5455.727213639302;5460.808871689551;5473.31583552056;5477.260569823103;4936.950630493721;5127.897502037005;5156.664816786897;5177.508136727005;5219.3736751589295;2894.8420631747467;2907.956380654292;2945.5287154055677;2958.2604348912773;2958.6538125153;5623.437656234344;5641.476801263718;5672.971635141798;5681.886362272814;5695.829125126253;5187.948120518822;5533.889322213614;5542.284280702427;5551.306086739158;5610.737584043639;5614.045612245928;5630.859228519238;5663.773449061991;5695.60130790849;5737.627054241544;5175.327207463006;5431.945680543144;5438.15708565173;5506.476884695948;5509.842932984118;5407.972960135174;5417.214503896992;5420.970015697005;5437.891242175214;5448.645838020516;5670.971645141748;5678.375378708256;5703.201551782837;6100;6287.7110192411365;4318.5681431856565;4322.913541729211;4342.457192850894;4343.826246950213;4344.066890233816;6144.586745048575;6185.8144255672405;6208.534359923115;6210.285817131088;6227.1282020516255;5729.942700573108;5956.821295361146;6012.496875781055;6084.927111808508;6092.9086063709965;5976.372480889618;6033.9698301508215;6038.396160383926;6042.758289668364;6061.393860613904;5691.402402747652;5899.318694172312;5944.613600115978;5955.553333499918;5994.100884867305;5964.731587078505;5971.522278217645;6025.156478092983;6049.969750151221;6069.51443884497;5880.588358815013;5883.55873309512;5897.941020589911;5957.361725525342;5961.791337303173 07:39:40 INFO - PROCESS | 14847 | |5;yui.html;784.7718320827904;797.330242596219;883.4964070479826;910.9043550427203;913.7852604637914;15978.920105399471;17464.476065718016;17681.46955591331;17690.823091769078;17791.64416711665;15833.12917789521;15866;15903.363865445397;16023.679526409465;16135.354585816583;824.7608193623856;830.4270053662983;842.4355681693249;842.6503001254472;847.588919374103;845.8646616541355;846.7332790171076;848.2111636178352;848.325581162977;851.0638297872352;871.7820544863785;872.8734333521668;875.4265955798962;875.6016012714232;877.9824403511926;857.7726902370877;863.1497974495118;868.3747701654798;870.6778491957953;872.215006494154;633.3444884544474;634.3814780588935;635.71710588788;637.5218586060455;638.0684201066449;14932;14948.850511494855;14949;15011.549653510303;15113.54659360221;14097.436102555885;14098.2950852458;14217.289135543182;14234.715305693828;14434.855651443457;11917.523299068114;11930.403479825975;12125.69685757863;12328.630141095782;12520.373981300898;4018.1160144768105;4028.47629808126;4107.609777071173;4119.073208528087;4226;58211;70993;72946;74482.62758686226;79599.60200198962;12272.815907761391;12403.379831008413;12440.688982775322;12764.425600847984;12989.636088210791;22783.202587909345;22913.312600622008;23049.7695023051;23066.423339416313;23071.769282307298;9518.286128540387;9547.045295470398;9608.471534065693;9649;9817.705468835946;5139.486051394905;5255.444093443258;5318.97340513295;5320.441353657888;5388.063505389572;3770.868019619355;3868.709846761448;3875.4961854958674;3878.2243551289853;3886.2810380079777;680.5134328954821;700.2227527444533;711.2212127720138;711.7829062136099;712.750537311947;755.1844008470838;763.1872056260065;814;832.5379414425053;840.7603832907593;10570.471476426303;10984.945075274733;11031.560855945208;11303.095752339794;11336.546538138547;737.2995654128599;784.0278055211496;823.2426167925523;833.1293797981124;860.2172023458622;5202.635815492955;5254.6847189168775;5266.420693723688;5273.156294992859;5320.627556071038;68626.65686671535;68888.31111688919;70549.2945070553;70925.45372731343;109671;67910.66044669745;77033.6148319266;97001.51499242459;97345;98018;58934.70532647395;85531.57234213913;86215.56892215498;88759;89911;9814.71362575116;10147.543360548942;10190.184785217016;10336.431496267476;10341.121004714383;51369;52146.47853521416;52235.73882130565;53743;54249.72875135599;74838;75704;76328;77492.61253693695;78413.60793196225;12903.935480322538;12905.225686458842;13187.406566704713;13215.66960825987;13307.534236301683;13933.164010159422;14823.962322637311;14827;14990.175540345386;15370.308336125125;13721.45114195421;13969.650758731113;14002.789958150432;14235.644108896946;14726;13231.603051908458;13837.654058648613;13851.515196968057;14052.578422647337;14193.148411095368;13650;13874.583762487142;14095.647608809863;14108.082974606617;14384.136951782926;10849.67450976472;11345.773084538429;11674.299542027506;11681.707957301136;11682.299062056303;10659.840102398315;11086.667399978014;11329.886701132884;11335.886641133484;11769.529218831492 07:39:40 INFO - PROCESS | 14847 | __end_tp_report 07:39:40 INFO - PROCESS | 14847 | __start_cc_report 07:39:40 INFO - PROCESS | 14847 | _x_x_mozilla_cycle_collect,345 07:39:40 INFO - PROCESS | 14847 | __end_cc_report 07:39:40 INFO - PROCESS | 14847 | __startTimestamp1467988780868__endTimestamp 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | ------- Summary: start ------- 07:39:40 INFO - PROCESS | 14847 | Number of tests: 6 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | [#0] dojo.html Cycles:165 Average:5621.30 Median:5832.39 stddev:630.93 (10.8%) stddev-sans-first:606.23 07:39:40 INFO - PROCESS | 14847 | Values: 3309.1 3348.3 3368.0 3377.5 3395.3 5590.0 5601.5 5626.6 5637.0 5686.9 5610.6 5670.1 5678.9 5712.0 5719.8 5078.7 5144.0 5171.1 5198.2 5210.6 5043.3 5072.6 5214.5 5220.0 5220.8 5153.2 5165.9 5167.7 5168.4 5211.7 5121.3 5128.9 5212.3 5219.0 5221.7 5029.4 5064.4 5143.3 5158.7 5173.6 5404.5 5481.3 5487.2 5561.7 5569.0 6029.7 6071.5 6072.5 6083.7 6090.8 5821.3 6148.8 6153.8 6160.3 6163.1 5616.6 5632.0 5642.8 5648.5 5681.5 6132.0 6154.7 6165.3 6173.2 6194.5 5723.6 5804.6 5870.2 5886.9 5888.9 5936.6 5996.0 6005.1 6028.8 6072.6 5951.4 5982.7 5993.6 6011.9 6040.9 5865.5 5895.2 5903.4 6060.6 6062.3 4597.7 4611.0 4615.7 4624.5 4627.1 4132.3 4135.2 4142.5 4144.8 4176.6 5746.4 5782.5 5796.0 5809.2 5832.4 5926.1 5933.3 5981.3 6023.8 6100.0 5789.8 5821.6 5821.7 5822.3 5824.7 5050.3 5115.2 5147.9 5162.3 5203.9 6311.3 6322.7 6334.6 6340.2 6341.1 5836.6 6123.9 6125.3 6127.1 6135.7 6224.5 6236.9 6290.6 6387.9 6392.4 5983.0 5983.2 5990.6 6002.8 6030.2 5880.2 6021.3 6129.2 6143.8 6145.3 5909.0 6003.9 6004.8 6005.5 6026.2 5865.7 5915.0 5976.6 5982.5 5989.0 5688.3 5722.9 5748.4 5840.4 5887.7 5860.9 5951.0 5974.2 6002.6 6006.7 5808.0 5832.4 5859.9 5869.5 5879.5 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | [#1] ext.html Cycles:180 Average:66303.11 Median:44271.17 stddev:147046.60 (332.1%) stddev-sans-first:147376.36 07:39:40 INFO - PROCESS | 14847 | Values: 599.2 638.9 656.5 667.3 672.8 35553.8 38907.0 47498.1 48494.8 48607.0 49199.8 49277.8 49316.0 49645.0 49685.8 9022.2 9105.4 9123.7 9147.7 9164.1 8931.9 8946.9 8993.1 9017.9 9034.3 9092.3 9120.2 9123.7 9131.8 9139.0 9002.5 9020.9 9050.9 9060.4 9078.5 9036.5 9054.0 9082.3 9144.9 9152.3 45297.3 45980.0 45999.0 46012.8 46081.8 3678.7 4170.6 4297.5 4302.0 4490.9 34253.7 34320.0 34703.7 35981.6 36216.6 4630.0 4763.7 4810.8 4817.6 4895.3 383393.0 384092.0 389517.0 389680.0 392137.0 35910.6 36682.6 36697.1 64891.0 65503.7 39657.0 39728.0 39736.2 39811.0 39828.2 15818.9 15957.8 15959.2 16005.2 16044.2 13486.1 13538.7 13546.7 13560.7 13568.3 9202.6 9271.6 9271.6 9282.7 9344.0 3482.2 3528.7 3541.5 3572.2 3609.9 1100.3 1188.0 1188.5 1189.9 1244.2 34211.0 34329.8 34735.1 35471.5 37659.6 1090.7 1203.6 1252.0 1258.0 1267.2 17626.5 17651.5 17848.8 17850.2 17896.9 549996.0 556575.0 588473.0 974509.0 986812.0 61260.0 62036.0 62135.4 62171.0 62352.4 1475.7 1487.2 1500.2 1517.8 1522.0 31817.5 31935.2 32868.2 33129.7 33177.8 53787.0 54247.0 54335.0 54492.0 54537.2 409130.0 411726.0 413937.0 415846.0 416828.0 29913.4 30385.7 30558.0 31191.7 31831.8 51921.5 52609.2 53246.7 53332.5 54157.7 44286.3 44463.8 44624.0 44649.1 45751.0 43047.4 44256.0 45492.5 46015.0 46220.8 45476.8 45546.8 46022.1 46279.0 46319.8 38196.8 38295.6 38334.8 39432.4 39703.6 30375.8 31031.4 31071.2 31293.7 31589.2 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | [#2] jquery.html Cycles:180 Average:28025.39 Median:12455.01 stddev:71437.79 (573.6%) stddev-sans-first:71608.15 07:39:40 INFO - PROCESS | 14847 | Values: 430.3 432.9 434.5 435.1 437.5 18241.2 19107.3 19784.0 20493.4 20544.8 19339.3 19469.0 19622.5 20381.8 20384.7 5143.6 5259.7 5298.0 5316.5 5318.0 5746.0 5894.7 5933.5 5951.2 5952.0 5857.0 5884.4 5888.8 5897.5 5904.7 5620.4 5800.7 5847.2 5865.4 5868.0 5251.8 5256.8 5272.2 5309.9 5314.7 22774.5 23733.8 24104.9 24389.0 24422.0 2652.3 2759.8 2930.9 2930.9 3163.8 14563.6 15005.7 15130.9 15243.5 15573.1 1868.8 1887.8 1891.8 1947.4 2043.8 77495.2 83553.0 88507.0 89258.0 96393.5 10413.1 11193.3 11642.9 11718.0 11792.8 16394.3 16552.6 16557.1 16583.6 16678.0 8685.7 9010.8 9075.9 9128.6 9249.8 8821.3 8895.7 8898.0 8962.7 9027.1 4424.0 4545.6 4658.9 4667.4 5084.5 1968.5 2067.9 2076.3 2098.7 2135.5 957.6 989.7 1014.7 1057.4 1090.5 18713.0 19417.9 19553.4 19933.6 20033.6 1049.4 1050.1 1055.0 1071.1 1138.4 11172.9 11421.3 11557.1 11557.7 11588.1 360221.0 362829.0 362967.0 512647.0 513317.0 76965.7 97406.5 100191.0 105937.0 107013.0 1089.8 1104.8 1116.3 1134.0 1134.7 18493.3 18596.5 18741.3 18828.4 19006.5 42286.9 43174.6 43769.0 44060.8 45357.8 60689.4 60998.0 61756.4 61773.0 63168.1 8284.7 8577.3 8663.0 8777.1 8837.6 12519.0 13442.7 13666.8 13861.4 14130.4 12118.8 12203.9 12288.3 12469.3 12613.0 11598.1 11793.4 11813.1 11940.8 12012.2 12352.1 12353.4 12366.6 12751.6 13169.9 8491.6 8579.5 8591.9 8716.7 8989.5 11115.3 11646.4 11701.7 11717.3 11794.6 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | [#3] mootools.html Cycles:180 Average:6253.87 Median:4368.92 stddev:3613.11 (82.7%) stddev-sans-first:3605.87 07:39:40 INFO - PROCESS | 14847 | Values: 1538.9 1579.4 1762.7 1889.1 1909.7 8367.7 8805.8 8988.4 9350.3 9444.6 8952.0 9266.1 9305.2 9388.5 9396.4 2441.2 2470.2 2474.1 2483.5 2494.1 2392.5 2498.2 2504.5 2507.2 2507.4 2434.7 2436.1 2436.7 2450.1 2465.4 2382.1 2415.5 2416.5 2442.2 2447.5 2380.7 2397.7 2426.7 2430.7 2440.8 9284.3 9433.6 9461.4 9497.6 9506.2 5586.7 5750.6 5762.7 5764.3 5766.9 3520.3 3545.8 3640.0 3663.6 3731.6 1131.2 1170.0 1178.4 1180.5 1188.8 13381.9 13425.2 13455.3 13521.9 13538.7 4731.8 4813.2 4860.9 4887.0 4922.5 11243.4 11282.7 11321.7 11333.7 11338.8 5609.2 5701.5 5725.1 5732.5 5738.9 4644.5 5095.0 5269.5 5272.7 5320.9 4232.4 4266.4 4305.6 4353.5 4384.4 1305.1 1319.0 1339.2 1339.5 1359.3 973.4 1053.5 1070.1 1091.7 1117.4 6449.7 6562.8 6572.3 6580.2 6632.0 461.6 486.7 1092.2 1165.3 1171.0 4208.5 4218.8 4274.7 4327.9 4336.4 11841.8 12087.5 12093.6 12132.5 12177.3 11666.9 12005.2 12029.5 12125.2 12172.8 8850.2 8867.5 8898.8 8964.6 8965.0 6520.9 6552.7 6578.8 6593.5 6615.4 10904.8 11093.7 11132.9 11154.8 11186.6 11026.6 11148.4 11249.1 11336.7 11339.2 7194.6 8059.1 8147.8 8721.4 9111.1 8879.6 9144.1 9176.0 9225.0 9238.5 8281.0 8475.0 8492.7 8510.9 8519.7 8213.7 8219.3 8324.4 8399.7 8423.3 6880.2 6885.5 6894.3 6895.2 7116.2 5399.3 5456.3 5564.9 5685.3 5816.4 5491.4 5534.6 5598.2 5608.8 5696.0 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | [#4] prototype.html Cycles:180 Average:4858.14 Median:5458.27 stddev:1412.94 (25.9%) stddev-sans-first:1375.18 07:39:40 INFO - PROCESS | 14847 | Values: 317.0 326.7 327.5 327.8 329.7 5506.3 5611.3 5616.0 5713.3 5741.3 5594.3 5622.6 5641.9 5649.8 5667.1 4389.3 4404.7 4409.1 4419.8 4421.9 4247.4 4427.9 4441.7 4442.2 4442.7 4345.7 4379.1 4392.8 4402.3 4409.7 4376.5 4430.1 4438.9 4446.1 4462.4 3787.7 3879.3 3910.8 3917.8 3923.8 5463.9 5471.4 5495.0 5513.4 5518.9 5023.7 5040.1 5050.5 5054.7 5059.7 5745.8 5938.2 5969.0 5981.9 5984.7 4236.7 4253.7 4255.8 4271.1 4287.6 6203.0 6203.5 6235.8 6239.3 6253.2 4266.5 4324.8 4357.5 4357.6 4360.1 4315.1 4376.9 4407.5 4411.6 4417.3 5016.8 5032.7 5039.1 5044.0 5056.1 5897.7 5944.5 5991.9 6036.0 6058.7 1493.1 1515.9 1527.2 1527.3 1530.8 947.7 963.5 966.3 969.4 981.2 5153.9 5159.7 5177.6 5189.7 5238.9 5422.4 5455.7 5460.8 5473.3 5477.3 4937.0 5127.9 5156.7 5177.5 5219.4 2894.8 2908.0 2945.5 2958.3 2958.7 5623.4 5641.5 5673.0 5681.9 5695.8 5187.9 5533.9 5542.3 5551.3 5610.7 5614.0 5630.9 5663.8 5695.6 5737.6 5175.3 5431.9 5438.2 5506.5 5509.8 5408.0 5417.2 5421.0 5437.9 5448.6 5671.0 5678.4 5703.2 6100.0 6287.7 4318.6 4322.9 4342.5 4343.8 4344.1 6144.6 6185.8 6208.5 6210.3 6227.1 5729.9 5956.8 6012.5 6084.9 6092.9 5976.4 6034.0 6038.4 6042.8 6061.4 5691.4 5899.3 5944.6 5955.6 5994.1 5964.7 5971.5 6025.2 6050.0 6069.5 5880.6 5883.6 5897.9 5957.4 5961.8 07:39:40 INFO - PROCESS | 14847 | 07:39:40 INFO - PROCESS | 14847 | [#5] yui.html Cycles:180 Average:19637.51 Median:28254.24 stddev:26051.15 (92.2%) stddev-sans-first:26085.76 07:39:40 INFO - PROCESS | 14847 | Values: 784.8 797.3 883.5 910.9 913.8 15978.9 17464.5 17681.5 17690.8 17791.6 15833.1 15866.0 15903.4 16023.7 16135.4 824.8 830.4 842.4 842.7 847.6 845.9 846.7 848.2 848.3 851.1 871.8 872.9 875.4 875.6 878.0 857.8 863.1 868.4 870.7 872.2 633.3 634.4 635.7 637.5 638.1 14932.0 14948.9 14949.0 15011.5 15113.5 14097.4 14098.3 14217.3 14234.7 14434.9 11917.5 11930.4 12125.7 12328.6 12520.4 4018.1 4028.5 4107.6 4119.1 4226.0 58211.0 70993.0 72946.0 74482.6 79599.6 12272.8 12403.4 12440.7 12764.4 12989.6 22783.2 22913.3 23049.8 23066.4 23071.8 9518.3 9547.0 9608.5 9649.0 9817.7 5139.5 5255.4 5319.0 5320.4 5388.1 3770.9 3868.7 3875.5 3878.2 3886.3 680.5 700.2 711.2 711.8 712.8 755.2 763.2 814.0 832.5 840.8 10570.5 10984.9 11031.6 11303.1 11336.5 737.3 784.0 823.2 833.1 860.2 5202.6 5254.7 5266.4 5273.2 5320.6 68626.7 68888.3 70549.3 70925.5 109671.0 67910.7 77033.6 97001.5 97345.0 98018.0 58934.7 85531.6 86215.6 88759.0 89911.0 9814.7 10147.5 10190.2 10336.4 10341.1 51369.0 52146.5 52235.7 53743.0 54249.7 74838.0 75704.0 76328.0 77492.6 78413.6 12903.9 12905.2 13187.4 13215.7 13307.5 13933.2 14824.0 14827.0 14990.2 15370.3 13721.5 13969.7 14002.8 14235.6 14726.0 13231.6 13837.7 13851.5 14052.6 14193.1 13650.0 13874.6 14095.6 14108.1 14384.1 10849.7 11345.8 11674.3 11681.7 11682.3 10659.8 11086.7 11329.9 11335.9 11769.5 07:39:40 INFO - PROCESS | 14847 | -------- Summary: end -------- 07:39:40 INFO - PROCESS | 14847 | 07:39:41 INFO - TEST-INFO | 14847: exit 0 07:39:41 INFO - TEST-OK | dromaeo_css | took 1109100ms 07:39:41 INFO - TEST-START | kraken 07:39:41 INFO - operating with platform_type : linux_ 07:39:41 INFO - Initialising browser for kraken test... 07:39:41 INFO - TEST-INFO | started process 15097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTzSueT/profile http://localhost:34876/getInfo.html) 07:39:45 INFO - PROCESS | 15097 | __metrics Screen width/height:1600/1200 07:39:45 INFO - PROCESS | 15097 | colorDepth:24 07:39:45 INFO - PROCESS | 15097 | Browser inner width/height: 1024/697 07:39:45 INFO - PROCESS | 15097 | __metrics 07:39:46 ERROR - PROCESS | 15097 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:39:46 INFO - TEST-INFO | 15097: exit 0 07:39:46 INFO - Browser initialized. 07:39:46 INFO - Running cycle 1/1 for kraken test... 07:39:46 INFO - TEST-INFO | started process 15228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTzSueT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:58 INFO - PROCESS | 15228 | RSS: Main: 155430912 07:39:58 INFO - PROCESS | 15228 | 07:40:01 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34876/tests/kraken/driver.html?testName=audio-beat-detection) 07:40:02 INFO - PROCESS | 15228 | RSS: Main: 160858112 07:40:02 INFO - PROCESS | 15228 | 07:40:04 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34876/tests/kraken/driver.html?testName=audio-dft) 07:40:05 INFO - PROCESS | 15228 | RSS: Main: 160309248 07:40:05 INFO - PROCESS | 15228 | 07:40:08 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34876/tests/kraken/driver.html?testName=audio-fft) 07:40:08 INFO - PROCESS | 15228 | RSS: Main: 160542720 07:40:08 INFO - PROCESS | 15228 | 07:40:10 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34876/tests/kraken/driver.html?testName=audio-oscillator) 07:40:11 INFO - PROCESS | 15228 | RSS: Main: 160358400 07:40:11 INFO - PROCESS | 15228 | 07:40:13 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:40:14 INFO - PROCESS | 15228 | RSS: Main: 160927744 07:40:14 INFO - PROCESS | 15228 | 07:40:17 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34876/tests/kraken/driver.html?testName=imaging-darkroom) 07:40:18 INFO - PROCESS | 15228 | RSS: Main: 160448512 07:40:18 INFO - PROCESS | 15228 | 07:40:21 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34876/tests/kraken/driver.html?testName=imaging-desaturate) 07:40:22 INFO - PROCESS | 15228 | RSS: Main: 161079296 07:40:22 INFO - PROCESS | 15228 | 07:40:24 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34876/tests/kraken/driver.html?testName=json-parse-financial) 07:40:25 INFO - PROCESS | 15228 | RSS: Main: 161374208 07:40:25 INFO - PROCESS | 15228 | 07:40:27 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:40:27 INFO - PROCESS | 15228 | RSS: Main: 160854016 07:40:27 INFO - PROCESS | 15228 | 07:40:29 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:40:30 INFO - PROCESS | 15228 | RSS: Main: 160804864 07:40:30 INFO - PROCESS | 15228 | 07:40:32 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:40:32 INFO - PROCESS | 15228 | RSS: Main: 161525760 07:40:32 INFO - PROCESS | 15228 | 07:40:35 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:40:36 INFO - PROCESS | 15228 | RSS: Main: 161533952 07:40:36 INFO - PROCESS | 15228 | 07:40:38 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:40:39 INFO - PROCESS | 15228 | RSS: Main: 161157120 07:40:39 INFO - PROCESS | 15228 | 07:40:40 INFO - PROCESS | 15228 | Cycle 1(1): loaded http://localhost:34876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34876/tests/kraken/driver.html?testName=ai-astar) 07:40:41 INFO - PROCESS | 15228 | RSS: Main: 162185216 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | __start_tp_report 07:40:41 INFO - PROCESS | 15228 | _x_x_mozilla_page_load 07:40:41 INFO - PROCESS | 15228 | _x_x_mozilla_page_load_details 07:40:41 INFO - PROCESS | 15228 | |i|pagename|runs| 07:40:41 INFO - PROCESS | 15228 | |0;ai-astar;116;105;111;112;112;113;113;111;111;110 07:40:41 INFO - PROCESS | 15228 | |1;audio-beat-detection;154;132;151;191;129;153;162;124;176;126 07:40:41 INFO - PROCESS | 15228 | |2;audio-dft;162;161;161;161;160;162;163;161;163;160 07:40:41 INFO - PROCESS | 15228 | |3;audio-fft;87;76;75;173;76;74;73;75;165;74 07:40:41 INFO - PROCESS | 15228 | |4;audio-oscillator;84;84;142;85;86;86;151;85;84;148 07:40:41 INFO - PROCESS | 15228 | |5;imaging-gaussian-blur;117;118;118;117;117;117;118;118;118;118 07:40:41 INFO - PROCESS | 15228 | |6;imaging-darkroom;149;148;147;147;147;148;147;147;148;146 07:40:41 INFO - PROCESS | 15228 | |7;imaging-desaturate;95;96;96;95;96;96;96;95;96;96 07:40:41 INFO - PROCESS | 15228 | |8;json-parse-financial;59;52;53;54;57;53;53;52;54;54 07:40:41 INFO - PROCESS | 15228 | |9;json-stringify-tinderbox;70;70;70;70;70;70;70;71;70;71 07:40:41 INFO - PROCESS | 15228 | |10;stanford-crypto-aes;76;83;78;75;82;77;80;78;104;78 07:40:41 INFO - PROCESS | 15228 | |11;stanford-crypto-ccm;123;135;133;137;126;118;126;122;124;121 07:40:41 INFO - PROCESS | 15228 | |12;stanford-crypto-pbkdf2;153;157;157;148;150;156;153;149;151;149 07:40:41 INFO - PROCESS | 15228 | |13;stanford-crypto-sha256-iterative;62;60;66;65;61;61;61;61;63;62 07:40:41 INFO - PROCESS | 15228 | __end_tp_report 07:40:41 INFO - PROCESS | 15228 | __start_cc_report 07:40:41 INFO - PROCESS | 15228 | _x_x_mozilla_cycle_collect,879 07:40:41 INFO - PROCESS | 15228 | __end_cc_report 07:40:41 INFO - PROCESS | 15228 | __startTimestamp1467988841191__endTimestamp 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | ------- Summary: start ------- 07:40:41 INFO - PROCESS | 15228 | Number of tests: 14 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.80 (2.5%) stddev-sans-first:2.42 07:40:41 INFO - PROCESS | 15228 | Values: 116.0 105.0 111.0 112.0 112.0 113.0 113.0 111.0 111.0 110.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:153.50 stddev:22.47 (14.6%) stddev-sans-first:23.78 07:40:41 INFO - PROCESS | 15228 | Values: 154.0 132.0 151.0 191.0 129.0 153.0 162.0 124.0 176.0 126.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 07:40:41 INFO - PROCESS | 15228 | Values: 162.0 161.0 161.0 161.0 160.0 162.0 163.0 161.0 163.0 160.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:39.35 (52.5%) stddev-sans-first:41.64 07:40:41 INFO - PROCESS | 15228 | Values: 87.0 76.0 75.0 173.0 76.0 74.0 73.0 75.0 165.0 74.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:84.50 stddev:30.10 (35.6%) stddev-sans-first:31.09 07:40:41 INFO - PROCESS | 15228 | Values: 84.0 84.0 142.0 85.0 86.0 86.0 151.0 85.0 84.0 148.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:40:41 INFO - PROCESS | 15228 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 07:40:41 INFO - PROCESS | 15228 | Values: 149.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 146.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:40:41 INFO - PROCESS | 15228 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:2.23 (4.1%) stddev-sans-first:1.51 07:40:41 INFO - PROCESS | 15228 | Values: 59.0 52.0 53.0 54.0 57.0 53.0 53.0 52.0 54.0 54.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:40:41 INFO - PROCESS | 15228 | Values: 70.0 70.0 70.0 70.0 70.0 70.0 70.0 71.0 70.0 71.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:78.00 stddev:8.43 (10.8%) stddev-sans-first:8.73 07:40:41 INFO - PROCESS | 15228 | Values: 76.0 83.0 78.0 75.0 82.0 77.0 80.0 78.0 104.0 78.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:126.00 stddev:6.38 (5.1%) stddev-sans-first:6.64 07:40:41 INFO - PROCESS | 15228 | Values: 123.0 135.0 133.0 137.0 126.0 118.0 126.0 122.0 124.0 121.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:153.00 stddev:3.43 (2.2%) stddev-sans-first:3.63 07:40:41 INFO - PROCESS | 15228 | Values: 153.0 157.0 157.0 148.0 150.0 156.0 153.0 149.0 151.0 149.0 07:40:41 INFO - PROCESS | 15228 | 07:40:41 INFO - PROCESS | 15228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.93 (3.1%) stddev-sans-first:2.05 07:40:41 INFO - PROCESS | 15228 | Values: 62.0 60.0 66.0 65.0 61.0 61.0 61.0 61.0 63.0 62.0 07:40:41 INFO - PROCESS | 15228 | -------- Summary: end -------- 07:40:41 INFO - PROCESS | 15228 | 07:40:42 INFO - TEST-INFO | 15228: exit 0 07:40:42 INFO - TEST-OK | kraken | took 60551ms 07:40:42 INFO - SUITE-END | took 1169s 07:40:42 INFO - Completed test suite (00:19:29) 07:40:42 INFO - javascript benchmark 07:40:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7564.308123341168, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.090000249931, 3348.26338205595, 3367.9663203367973, 3377.5440315557394, 3395.286989732156, 5589.972050139749, 5601.4958653721205, 5626.578006649503, 5637.0, 5686.943130568693, 5610.579206559504, 5670.064439367509, 5678.858028549288, 5712.028955077636, 5719.799807006755, 5078.74606269686, 5143.974280128594, 5171.120909445384, 5198.220266959967, 5210.557102646279, 5043.319151914481, 5072.594192464594, 5214.452482489341, 5220.0, 5220.817271395502, 5153.1754919212935, 5165.948340516585, 5167.664101833388, 5168.405633352157, 5211.687298762067, 5121.28302037715, 5128.8974220515565, 5212.270282160501, 5219.0, 5221.738913054332, 5029.3964724232965, 5064.392272927235, 5143.3313669223135, 5158.69047857126, 5173.586113110942, 5404.486573775485, 5481.314835645544, 5487.204355368449, 5561.694106824123, 5569.0, 6029.698515074228, 6071.51427885768, 6072.453479186895, 6083.726232319556, 6090.786822461193, 5821.27234095738, 6148.754049838001, 6153.753849846001, 6160.322364539897, 6163.137160797492, 5616.634918730269, 5632.014397480466, 5642.802501912413, 5648.491635752802, 5681.488666020078, 6131.96934015336, 6154.661493617805, 6165.32181460039, 6173.166622505994, 6194.5044396448175, 5723.627964182315, 5804.593678442553, 5870.207521984563, 5886.911696324559, 5888.911666325009, 5936.584439089309, 5995.970020149872, 6005.099235114768, 6028.788992385245, 6072.574919755663, 5951.404859514014, 5982.700864956735, 5993.61041532299, 6011.939880601226, 6040.939590604038, 5865.472107510344, 5895.204147440127, 5903.35063143054, 6060.575759696867, 6062.302835174011, 4597.655175861823, 4610.95389046112, 4615.699979501322, 4624.5144259852905, 4627.097715945426, 4132.318167502329, 4135.17296540693, 4142.502899652, 4144.79276036203, 4176.644985176234, 5746.396628353963, 5782.508486778587, 5796.0, 5809.244798176294, 5832.387599302012, 5926.111083337534, 5933.317668468181, 5981.252343457068, 6023.789167379121, 6100.0, 5789.797357092481, 5821.621594596338, 5821.679807610537, 5822.33043200029, 5824.737886795019, 5050.267711181858, 5115.18157094863, 5147.922781158286, 5162.328897243409, 5203.947960520422, 6311.33730958252, 6322.71547780351, 6334.619922804646, 6340.207474065742, 6341.143945567289, 5836.562257830765, 6123.877522449615, 6125.326214116443, 6127.080937859357, 6135.7238924249405, 6224.533160012927, 6236.937630623635, 6290.591111577733, 6387.936120638734, 6392.360763923756, 5983.0, 5983.162357270073, 5990.550708696952, 6002.789902353396, 6030.185924900258, 5880.206172166702, 6021.277446706424, 6129.172561704113, 6143.754249829957, 6145.262568491809, 5908.970455147697, 6003.879922401615, 6004.759809607742, 6005.489533389711, 6026.15633811258, 5865.706714664335, 5914.970425147847, 5976.641401515749, 5982.52139828804, 5988.970055149696, 5688.288963879515, 5722.942770572241, 5748.367679555329, 5840.415958404125, 5887.7056147191615, 5860.912086318794, 5950.98833198366, 5974.22335096452, 6002.579819412599, 6006.669633170218, 5808.041673124057, 5832.358440571449, 5859.94140058594, 5869.530437564899, 5879.470847623564], "value": 5579.811609563799, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.226997173646, 638.9265234498034, 656.464981040452, 667.2693400726206, 672.7678950761987, 35553.82223088884, 38907.0, 47498.050038999245, 48494.75752621232, 48607.0, 49199.75400122994, 49277.75361123189, 49316.0, 49645.0, 49685.75157124218, 9022.233110185625, 9105.36262461628, 9123.68067117651, 9147.679831205909, 9164.129407706258, 8931.866022009675, 8946.910530894673, 8993.100689930987, 9017.864732029026, 9034.27725781939, 9092.318076144282, 9120.224780893632, 9123.726288211332, 9131.817363652723, 9139.0, 9002.459852408843, 9020.909790902106, 9050.909490905105, 9060.365774395796, 9078.546072696405, 9036.50299233542, 9053.954730226307, 9082.273418126533, 9144.908550914472, 9152.31357648179, 45297.32054019159, 45980.0, 45999.0, 46012.76993615044, 46081.769591152166, 3678.742488025839, 4170.624643782075, 4297.5272720001085, 4302.0, 4490.865274041784, 34253.6574634253, 34320.0, 34703.6529634703, 35981.640183598094, 36216.63783362159, 4630.0, 4763.69036012658, 4810.759462026885, 4817.590504807095, 4895.265710143472, 383393.0, 384092.0, 389517.0, 389680.0, 392137.0, 35910.640893591255, 36682.63317366792, 36697.08257293589, 64891.0, 65503.67248163824, 39657.0, 39728.0, 39736.20527589432, 39811.0, 39828.20343593112, 15818.9209053954, 15957.840421595867, 15959.202039897958, 16005.199740012953, 16044.197790110447, 13486.12340197884, 13538.729225415436, 13546.729065418636, 13560.660983475493, 13568.321583920764, 9202.63189472427, 9271.629134834531, 9271.629134834666, 9282.675106371245, 9343.953280233556, 3482.21650128719, 3528.7353448491467, 3541.451075083366, 3572.2319701264355, 3609.873654422135, 1100.2628239079836, 1187.9821802672966, 1188.5483516263937, 1189.9409525522292, 1244.1539752967888, 34211.0, 34329.82835085859, 34735.13162170966, 35471.4679279811, 37659.623403766156, 1090.6946055104584, 1203.602811072344, 1251.993740031294, 1257.9811302830465, 1267.1889990406148, 17626.471205863843, 17651.470455886087, 17848.821511784976, 17850.19674114642, 17896.9105154476, 549996.0, 556575.0, 588473.0, 974509.0, 986812.0, 61260.0, 62036.0, 62135.37864621296, 62171.0, 62352.376476234655, 1475.6605980624518, 1487.196913666608, 1500.2348802111003, 1517.7950976618015, 1522.0411140981112, 31817.5227371585, 31935.201619959687, 32868.178295542806, 33129.66870331266, 33177.83411082929, 53787.0, 54247.0, 54335.0, 54492.0, 54537.181942271694, 409130.0, 411726.0, 413937.0, 415846.0, 416828.0, 29913.401731965674, 30385.696143038287, 30558.0, 31191.688083119785, 31831.84084079565, 51921.48078519166, 52609.210861836335, 53246.73376633092, 53332.46667533275, 54157.72921135369, 44286.335704965095, 44463.77768111139, 44624.0, 44649.10701786011, 45751.0, 43047.35428968631, 44256.0, 45492.54507455016, 46015.0, 46220.76889615531, 45476.77261613671, 45546.772266138454, 46022.079558407975, 46279.0, 46319.84200395017, 38196.80901595474, 38295.6170438292, 38334.80832595819, 39432.40851387174, 39703.60296397115, 30375.848120759256, 31031.379372412877, 31071.223219419695, 31293.687063129077, 31589.210269743442], "value": 20308.916307763186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.2814300118802, 432.8658115984043, 434.52092599932473, 435.11888425937474, 437.5274703320412, 18241.179146938386, 19107.3312434065, 19784.0, 20493.38519844407, 20544.79455205451, 19339.323123690672, 19469.0, 19622.509437264074, 20381.796182038175, 20384.69422958653, 5143.614228932826, 5259.737013149346, 5297.973510132444, 5316.494932981361, 5318.0, 5745.994450971084, 5894.705264736767, 5933.525317974551, 5951.196588460546, 5952.0, 5856.970715146418, 5884.352721200665, 5888.793892213774, 5897.4692277695, 5904.7047647617665, 5620.4098569650005, 5800.651960882361, 5847.239858818348, 5865.442782935615, 5867.970660146715, 5251.842444726664, 5256.763445644917, 5272.209168624737, 5309.946900531023, 5314.73426328682, 22774.544509109724, 23733.7626623735, 24104.879475602684, 24389.0, 24422.0, 2652.3103992961774, 2759.8206116602355, 2930.868110935013, 2930.8827646894097, 3163.7785355025158, 14563.635909102251, 15005.69988600222, 15130.924345378202, 15243.466478673194, 15573.065616063073, 1868.8037756035556, 1887.8017808130223, 1891.8391936685398, 1947.4157752674141, 2043.7751847296786, 77495.22504774993, 83553.0, 88507.0, 89258.0, 96393.5180324101, 10413.114885234689, 11193.272437291713, 11642.88357116435, 11718.0, 11792.823107653221, 16394.26225819841, 16552.586185345222, 16557.089360085312, 16583.585410364594, 16678.0, 8685.739427817176, 9010.774730631656, 9075.863862042075, 9128.58921348541, 9249.815003700023, 8821.338399620054, 8895.688650897187, 8898.0, 8962.68630597926, 9027.097290271051, 4424.0, 4545.5908968193025, 4658.883527911761, 4667.393238878924, 5084.542391184811, 1968.517713160285, 2067.917283308651, 2076.2940600196007, 2098.7166732491223, 2135.4661334666334, 957.6408846682494, 989.6536212325628, 1014.6803756816579, 1057.4078516031047, 1090.547422819537, 18713.0, 19417.902910485638, 19553.413397598095, 19933.60132797365, 20033.59932801336, 1049.4123290956936, 1050.1179009631794, 1054.9578016879238, 1071.137734124022, 1138.4364739454024, 11172.888271117185, 11421.257618254787, 11557.07543396543, 11557.653270401901, 11588.13089018327, 360221.0, 362829.0, 362967.0, 512647.0, 513317.0, 76965.74843608186, 97406.51296743471, 100191.0, 105937.0, 107013.0, 1089.803835309636, 1104.812181929074, 1116.3302018788825, 1134.013408334754, 1134.7219931116765, 18493.260269589606, 18596.535086622942, 18741.34405295808, 18828.435146945612, 19006.524836879187, 42286.942826429586, 43174.568254317055, 43769.0, 44060.779696101315, 45357.77321113373, 60689.39310607014, 60998.0, 61756.38243617507, 61773.0, 63168.052479213766, 8284.668613255402, 8577.31381489467, 8662.956685216786, 8777.078406767198, 8837.602307896288, 12519.0, 13442.731145376842, 13666.794998074838, 13861.4455421782, 14130.364133613806, 12118.818217726564, 12203.938980305042, 12288.324142172267, 12469.251844889335, 12613.0, 11598.130140239347, 11793.351365674971, 11813.11401644863, 11940.761184776082, 12012.219205751948, 12352.135350525736, 12353.3823308836, 12366.567170149001, 12751.61745147647, 13169.934150329187, 8491.617877195664, 8579.528125953133, 8591.914080859111, 8716.694915677921, 8989.46063236208, 11115.277506962022, 11646.417679116179, 11701.707457313636, 11717.296962182296, 11794.587189448328], "value": 9670.84038963572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.8768898488122, 1579.447193482281, 1762.7267773495112, 1889.1309997401204, 1909.7135429685554, 8367.707130250443, 8805.779855503608, 8988.415752976052, 9350.298727595433, 9444.622215111396, 8952.0, 9266.119718626736, 9305.162535371815, 9388.530573471333, 9396.38923469974, 2441.1578005588044, 2470.17249221511, 2474.084588702183, 2483.50329934013, 2494.077191439161, 2392.473655795722, 2498.150628786212, 2504.474060447308, 2507.247825652297, 2507.448361360498, 2434.6834911461483, 2436.11081955086, 2436.683231179953, 2450.0567281596623, 2465.3713303107684, 2382.1424287256573, 2415.4565222824813, 2416.516696660666, 2442.218490083174, 2447.5349683560066, 2380.666706661069, 2397.748236435184, 2426.696662917135, 2430.6597076409316, 2440.7803297703113, 9284.25725941923, 9433.622655093788, 9461.432314061109, 9497.572609232531, 9506.239500839916, 5586.748596313135, 5750.6262092963825, 5762.74067666956, 5764.250647415809, 5766.855828604276, 3520.3487354839435, 3545.840437180307, 3639.981800091009, 3663.5786884508357, 3731.570869350005, 1131.242067814558, 1170.034721354877, 1178.4225729392622, 1180.4687890449331, 1188.7622475504847, 13381.866181338257, 13425.194488330731, 13455.259960702157, 13521.932390337985, 13538.661533461545, 4731.827005508304, 4813.15769740294, 4860.854174374775, 4887.0, 4922.483139270396, 11243.437828108561, 11282.661520154408, 11321.660350189508, 11333.659990200307, 11338.829917551244, 5609.158626206102, 5701.458361455655, 5725.141228815711, 5732.484076433141, 5738.856528586819, 4644.535546445396, 5095.0, 5269.499397557226, 5272.657277276965, 5320.920186197211, 4232.407462955189, 4266.381374700713, 4305.590968857953, 4353.477582690034, 4384.364267181305, 1305.0603565432873, 1319.0, 1339.1964821107451, 1339.4909934224931, 1359.34071975092, 973.4013581647235, 1053.4837929414532, 1070.0957690751302, 1091.7434402915308, 1117.391021893054, 6449.709763060673, 6562.80311590653, 6572.277049524549, 6580.243272023683, 6632.0, 461.5684335146649, 486.66906503577906, 1092.2408925796494, 1165.347405452949, 1170.9824352634716, 4208.452901122896, 4218.8312467500955, 4274.7435153890865, 4327.870163895088, 4336.371226172188, 11841.822372664417, 12087.516499340103, 12093.637190884112, 12132.5146994121, 12177.269363838199, 11666.941665291619, 12005.159638825373, 12029.518819247307, 12125.211861228992, 12172.81740773889, 8850.20348168655, 8867.512286824158, 8898.822023559493, 8964.641414343354, 8965.0, 6520.902186467112, 6552.705128269144, 6578.8355291118105, 6593.538452308292, 6615.37153970372, 10904.836427453436, 11093.722656933642, 11132.888671113185, 11154.776904462027, 11186.608468703556, 11026.558937642725, 11148.386838723947, 11249.100071994057, 11336.716582085513, 11339.206255562032, 7194.640267986475, 8059.1134975153855, 8147.79630509242, 8721.433106848035, 9111.088891110836, 8879.644814207359, 9144.131307525775, 9176.0, 9225.0, 9238.491882946502, 8280.958595206985, 8475.0, 8492.74521764348, 8510.872336914827, 8519.701810436605, 8213.671453141807, 8219.301359384519, 8324.375671824759, 8399.70601028961, 8423.326133909395, 6880.2431732508385, 6885.483588730765, 6894.310568943066, 6895.172579290517, 7116.217216106328, 5399.325084364455, 5456.263404440349, 5564.888702226014, 5685.289338832646, 5816.41835816415, 5491.423400543045, 5534.557235421076, 5598.160275958476, 5608.831735047955, 5695.971520142372], "value": 4965.206706295102, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.96037995250595, 326.72391828904574, 327.4515187061672, 327.75254682714547, 329.73785840257005, 5506.311711036121, 5611.270534830476, 5615.971920140399, 5713.342965558962, 5741.282339707536, 5594.272744543214, 5622.606417550773, 5641.887162256763, 5649.830505084844, 5667.149927510875, 4389.341598760179, 4404.735715857043, 4409.096135292258, 4419.845305414311, 4421.911561768763, 4247.362895565674, 4427.867163985085, 4441.689081764278, 4442.222611043071, 4442.689011769177, 4345.718013186102, 4379.146066517031, 4392.758398288093, 4402.295632698769, 4409.669274804386, 4376.452943382062, 4430.113977204556, 4438.911221775546, 4446.088182081704, 4462.3752674625575, 3787.7088846692386, 3879.321118804226, 3910.7513179921657, 3917.764934103963, 3923.7645741255333, 5463.863403414906, 5471.37079235889, 5494.972525137388, 5513.448655134494, 5518.889622207534, 5023.748812559394, 5040.092783299005, 5050.494950504957, 5054.7472626368535, 5059.747012649353, 5745.798897038625, 5938.228030356069, 5969.0, 5981.8803623927715, 5984.743203927181, 4236.724612900151, 4253.659707223414, 4255.787210639455, 4271.124419493996, 4287.571242875719, 6203.0075187969705, 6203.534734894856, 6235.781747638811, 6239.2824825145235, 6253.249610046778, 4266.488021437447, 4324.805383757738, 4357.520672725997, 4357.586029327209, 4360.127974405132, 4315.136972605492, 4376.868693939124, 4407.515173330931, 4411.647068234533, 4417.293233082692, 5016.774245158977, 5032.6980381177245, 5039.102516053211, 5043.9747801260755, 5056.092746670605, 5897.675627840425, 5944.464998150187, 5991.880162396727, 6035.969820150871, 6058.666773327509, 1493.11905975475, 1515.909045457276, 1527.2211172302207, 1527.3356090100842, 1530.8469153084602, 947.6777895515557, 963.5471328475745, 966.2994329111478, 969.4328817641617, 981.1562056631292, 5153.871153221199, 5159.716215608178, 5177.58579313654, 5189.6886186828915, 5238.947610523922, 5422.3764267109, 5455.727213639302, 5460.808871689551, 5473.31583552056, 5477.260569823103, 4936.950630493721, 5127.897502037005, 5156.664816786897, 5177.508136727005, 5219.3736751589295, 2894.8420631747467, 2907.956380654292, 2945.5287154055677, 2958.2604348912773, 2958.6538125153, 5623.437656234344, 5641.476801263718, 5672.971635141798, 5681.886362272814, 5695.829125126253, 5187.948120518822, 5533.889322213614, 5542.284280702427, 5551.306086739158, 5610.737584043639, 5614.045612245928, 5630.859228519238, 5663.773449061991, 5695.60130790849, 5737.627054241544, 5175.327207463006, 5431.945680543144, 5438.15708565173, 5506.476884695948, 5509.842932984118, 5407.972960135174, 5417.214503896992, 5420.970015697005, 5437.891242175214, 5448.645838020516, 5670.971645141748, 5678.375378708256, 5703.201551782837, 6100.0, 6287.7110192411365, 4318.5681431856565, 4322.913541729211, 4342.457192850894, 4343.826246950213, 4344.066890233816, 6144.586745048575, 6185.8144255672405, 6208.534359923115, 6210.285817131088, 6227.1282020516255, 5729.942700573108, 5956.821295361146, 6012.496875781055, 6084.927111808508, 6092.9086063709965, 5976.372480889618, 6033.9698301508215, 6038.396160383926, 6042.758289668364, 6061.393860613904, 5691.402402747652, 5899.318694172312, 5944.613600115978, 5955.553333499918, 5994.100884867305, 5964.731587078505, 5971.522278217645, 6025.156478092983, 6049.969750151221, 6069.51443884497, 5880.588358815013, 5883.55873309512, 5897.941020589911, 5957.361725525342, 5961.791337303173], "value": 4400.296881221641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.7718320827904, 797.330242596219, 883.4964070479826, 910.9043550427203, 913.7852604637914, 15978.920105399471, 17464.476065718016, 17681.46955591331, 17690.823091769078, 17791.64416711665, 15833.12917789521, 15866.0, 15903.363865445397, 16023.679526409465, 16135.354585816583, 824.7608193623856, 830.4270053662983, 842.4355681693249, 842.6503001254472, 847.588919374103, 845.8646616541355, 846.7332790171076, 848.2111636178352, 848.325581162977, 851.0638297872352, 871.7820544863785, 872.8734333521668, 875.4265955798962, 875.6016012714232, 877.9824403511926, 857.7726902370877, 863.1497974495118, 868.3747701654798, 870.6778491957953, 872.215006494154, 633.3444884544474, 634.3814780588935, 635.71710588788, 637.5218586060455, 638.0684201066449, 14932.0, 14948.850511494855, 14949.0, 15011.549653510303, 15113.54659360221, 14097.436102555885, 14098.2950852458, 14217.289135543182, 14234.715305693828, 14434.855651443457, 11917.523299068114, 11930.403479825975, 12125.69685757863, 12328.630141095782, 12520.373981300898, 4018.1160144768105, 4028.47629808126, 4107.609777071173, 4119.073208528087, 4226.0, 58211.0, 70993.0, 72946.0, 74482.62758686226, 79599.60200198962, 12272.815907761391, 12403.379831008413, 12440.688982775322, 12764.425600847984, 12989.636088210791, 22783.202587909345, 22913.312600622008, 23049.7695023051, 23066.423339416313, 23071.769282307298, 9518.286128540387, 9547.045295470398, 9608.471534065693, 9649.0, 9817.705468835946, 5139.486051394905, 5255.444093443258, 5318.97340513295, 5320.441353657888, 5388.063505389572, 3770.868019619355, 3868.709846761448, 3875.4961854958674, 3878.2243551289853, 3886.2810380079777, 680.5134328954821, 700.2227527444533, 711.2212127720138, 711.7829062136099, 712.750537311947, 755.1844008470838, 763.1872056260065, 814.0, 832.5379414425053, 840.7603832907593, 10570.471476426303, 10984.945075274733, 11031.560855945208, 11303.095752339794, 11336.546538138547, 737.2995654128599, 784.0278055211496, 823.2426167925523, 833.1293797981124, 860.2172023458622, 5202.635815492955, 5254.6847189168775, 5266.420693723688, 5273.156294992859, 5320.627556071038, 68626.65686671535, 68888.31111688919, 70549.2945070553, 70925.45372731343, 109671.0, 67910.66044669745, 77033.6148319266, 97001.51499242459, 97345.0, 98018.0, 58934.70532647395, 85531.57234213913, 86215.56892215498, 88759.0, 89911.0, 9814.71362575116, 10147.543360548942, 10190.184785217016, 10336.431496267476, 10341.121004714383, 51369.0, 52146.47853521416, 52235.73882130565, 53743.0, 54249.72875135599, 74838.0, 75704.0, 76328.0, 77492.61253693695, 78413.60793196225, 12903.935480322538, 12905.225686458842, 13187.406566704713, 13215.66960825987, 13307.534236301683, 13933.164010159422, 14823.962322637311, 14827.0, 14990.175540345386, 15370.308336125125, 13721.45114195421, 13969.650758731113, 14002.789958150432, 14235.644108896946, 14726.0, 13231.603051908458, 13837.654058648613, 13851.515196968057, 14052.578422647337, 14193.148411095368, 13650.0, 13874.583762487142, 14095.647608809863, 14108.082974606617, 14384.136951782926, 10849.67450976472, 11345.773084538429, 11674.299542027506, 11681.707957301136, 11682.299062056303, 10659.840102398315, 11086.667399978014, 11329.886701132884, 11335.886641133484, 11769.529218831492], "value": 7823.194752906135, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 105.0, 111.0, 112.0, 112.0, 113.0, 113.0, 111.0, 111.0, 110.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 151.0, 191.0, 129.0, 153.0, 162.0, 124.0, 176.0, 126.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 163.0, 161.0, 163.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 76.0, 75.0, 173.0, 76.0, 74.0, 73.0, 75.0, 165.0, 74.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 142.0, 85.0, 86.0, 86.0, 151.0, 85.0, 84.0, 148.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 52.0, 53.0, 54.0, 57.0, 53.0, 53.0, 52.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 78.0, 75.0, 82.0, 77.0, 80.0, 78.0, 104.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 135.0, 133.0, 137.0, 126.0, 118.0, 126.0, 122.0, 124.0, 121.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 157.0, 148.0, 150.0, 156.0, 153.0, 149.0, 151.0, 149.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 66.0, 65.0, 61.0, 61.0, 61.0, 61.0, 63.0, 62.0], "value": 62.2, "unit": "score"}]}]} 07:40:42 INFO - Return code: 0 07:40:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:40:42 ERROR - # TBPL SUCCESS # 07:40:42 INFO - Running post-action listener: _resource_record_post_action 07:40:42 INFO - ##### 07:40:42 INFO - ##### Finished run-tests step (success) 07:40:42 INFO - ##### 07:40:42 INFO - Running post-run listener: _resource_record_post_run 07:40:42 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506634240; Read time: 8; Write time: 382684 07:40:42 INFO - TinderboxPrint: CPU usage
13.4% 07:40:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:40:42 INFO - TinderboxPrint: I/O write bytes / time
506,634,240 / 382,684 07:40:42 INFO - TinderboxPrint: CPU idle
8,197.9 (86.6%) 07:40:42 INFO - TinderboxPrint: CPU user
1,218.4 (12.9%) 07:40:42 INFO - TinderboxPrint: Swap in / out
0 / 0 07:40:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 264073216; Read time: 0; Write time: 234168 07:40:42 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 242561024; Read time: 8; Write time: 148516 07:40:43 INFO - Running post-run listener: _upload_blobber_files 07:40:43 INFO - Blob upload gear active. 07:40:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:40:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:40:43 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'] 07:40:43 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 07:40:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:44 INFO - (blobuploader) - INFO - Done attempting. 07:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:48 INFO - (blobuploader) - INFO - Done attempting. 07:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:48 INFO - (blobuploader) - INFO - Done attempting. 07:40:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:40:48 INFO - Return code: 0 07:40:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:40:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:40:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1442352ea4fd9e98e9116aed2e4e657e9cff9eecbd4a9bd997ff5d9535ef7499ef79fcf5b3528041e07e745224151506134aa9909214f3c68fe3a727d7a6701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d00a39d321742b0e4728308ba7a9cadd539e5855d572a468e0cdd3e30d8e3d57e10b482dba6c3bacf98e945ed0f75065d83ddcf77353ffbb09e407bf936fc7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6405b87382042757b6adcf168726419fa9d17db2e4d6ef13f686af43c49182d26ed4a388650fd3ce14782f78698d73a7dda873c3e746d812a317cda839a58d2"} 07:40:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:40:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:40:48 INFO - Contents: 07:40:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1442352ea4fd9e98e9116aed2e4e657e9cff9eecbd4a9bd997ff5d9535ef7499ef79fcf5b3528041e07e745224151506134aa9909214f3c68fe3a727d7a6701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d00a39d321742b0e4728308ba7a9cadd539e5855d572a468e0cdd3e30d8e3d57e10b482dba6c3bacf98e945ed0f75065d83ddcf77353ffbb09e407bf936fc7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6405b87382042757b6adcf168726419fa9d17db2e4d6ef13f686af43c49182d26ed4a388650fd3ce14782f78698d73a7dda873c3e746d812a317cda839a58d2"} 07:40:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:40:48 INFO - Copying logs to upload dir... 07:40:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:40:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.456468 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-08 07:40:48.659268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:40:48.662437) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1442352ea4fd9e98e9116aed2e4e657e9cff9eecbd4a9bd997ff5d9535ef7499ef79fcf5b3528041e07e745224151506134aa9909214f3c68fe3a727d7a6701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d00a39d321742b0e4728308ba7a9cadd539e5855d572a468e0cdd3e30d8e3d57e10b482dba6c3bacf98e945ed0f75065d83ddcf77353ffbb09e407bf936fc7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6405b87382042757b6adcf168726419fa9d17db2e4d6ef13f686af43c49182d26ed4a388650fd3ce14782f78698d73a7dda873c3e746d812a317cda839a58d2"} build_url:https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1442352ea4fd9e98e9116aed2e4e657e9cff9eecbd4a9bd997ff5d9535ef7499ef79fcf5b3528041e07e745224151506134aa9909214f3c68fe3a727d7a6701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d00a39d321742b0e4728308ba7a9cadd539e5855d572a468e0cdd3e30d8e3d57e10b482dba6c3bacf98e945ed0f75065d83ddcf77353ffbb09e407bf936fc7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6405b87382042757b6adcf168726419fa9d17db2e4d6ef13f686af43c49182d26ed4a388650fd3ce14782f78698d73a7dda873c3e746d812a317cda839a58d2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:40:48.688103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:40:48.688406) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1467987618.437728-432289281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:40:48.774099) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:40:48.774457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:40:48.774798) ========= ========= Total master_lag: 0.17 =========