builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1467987521.71 results: success (0) buildid: 20160708040825 builduid: 75d019f3c1f748868951ac2ae11eaf5e revision: dd939576757577e1580b84e0820f9eb2d77dd303 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.706559) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.707067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.707357) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.722773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.723200) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 07:18:41-- 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% 47.0M=0s 2016-07-08 07:18:41 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.838425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.838839) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016707 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.888911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:41.889300) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 07:18:42,103 truncating revision to first 12 chars 2016-07-08 07:18:42,103 Setting DEBUG logging. 2016-07-08 07:18:42,103 attempt 1/10 2016-07-08 07:18:42,103 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:18:42,586 unpacking tar archive at: mozilla-aurora-dd9395767575/testing/mozharness/ program finished with exit code 0 elapsedTime=0.806770 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:42.710532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:42.710905) ========= script_repo_revision: dd939576757577e1580b84e0820f9eb2d77dd303 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:42.711394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:42.711694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 07:18:42.722477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-08 07:18:42.722933) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:43 INFO - MultiFileLogger online at 20160708 07:18:43 in /builds/slave/test 07:18:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:18:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:43 INFO - {'append_to_log': False, 07:18:43 INFO - 'base_work_dir': '/builds/slave/test', 07:18:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:18:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:43 INFO - 'branch': 'Mozilla-Aurora', 07:18:43 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:43 INFO - 'config_files': ('talos/linux_config.py',), 07:18:43 INFO - 'default_actions': ('clobber', 07:18:43 INFO - 'read-buildbot-config', 07:18:43 INFO - 'download-and-extract', 07:18:43 INFO - 'populate-webroot', 07:18:43 INFO - 'create-virtualenv', 07:18:43 INFO - 'install', 07:18:43 INFO - 'run-tests'), 07:18:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:43 INFO - 'download_minidump_stackwalk': True, 07:18:43 INFO - 'download_symbols': 'ondemand', 07:18:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:43 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:43 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:43 INFO - 'installer_path': 'installer.exe', 07:18:43 INFO - 'log_level': 'info', 07:18:43 INFO - 'log_name': 'talos', 07:18:43 INFO - 'log_to_console': True, 07:18:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:43 INFO - 'opt_config_files': (), 07:18:43 INFO - 'pip_index': False, 07:18:43 INFO - 'sps_profile': False, 07:18:43 INFO - 'sps_profile_interval': 0, 07:18:43 INFO - 'suite': 'dromaeojs', 07:18:43 INFO - 'system_bits': '32', 07:18:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:43 INFO - 'title': 'talos-linux64-ix-006', 07:18:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:43 INFO - 'use_talos_json': True, 07:18:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:43 INFO - 'work_dir': 'build'} 07:18:43 INFO - ##### 07:18:43 INFO - ##### Running clobber step. 07:18:43 INFO - ##### 07:18:43 INFO - Running pre-action listener: _resource_record_pre_action 07:18:43 INFO - Running main action method: clobber 07:18:43 INFO - rmtree: /builds/slave/test/build 07:18:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:43 INFO - Running post-action listener: _resource_record_post_action 07:18:43 INFO - ##### 07:18:43 INFO - ##### Finished clobber step (success) 07:18:43 INFO - ##### 07:18:43 INFO - ##### 07:18:43 INFO - ##### Running read-buildbot-config step. 07:18:43 INFO - ##### 07:18:43 INFO - Running pre-action listener: _resource_record_pre_action 07:18:43 INFO - Running main action method: read_buildbot_config 07:18:43 INFO - Using buildbot properties: 07:18:43 INFO - { 07:18:43 INFO - "project": "", 07:18:43 INFO - "product": "firefox", 07:18:43 INFO - "script_repo_revision": "production", 07:18:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:18:43 INFO - "repository": "", 07:18:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:18:43 INFO - "buildid": "20160708040825", 07:18:43 INFO - "pgo_build": "True", 07:18:43 INFO - "basedir": "/builds/slave/test", 07:18:43 INFO - "buildnumber": 356, 07:18:43 INFO - "slavename": "talos-linux64-ix-006", 07:18:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:18:43 INFO - "platform": "ubuntu64_hw", 07:18:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:18:43 INFO - "branch": "mozilla-aurora", 07:18:43 INFO - "repo_path": "releases/mozilla-aurora", 07:18:43 INFO - "revision": "dd939576757577e1580b84e0820f9eb2d77dd303", 07:18:43 INFO - "stage_platform": "linux64-pgo", 07:18:43 INFO - "builduid": "75d019f3c1f748868951ac2ae11eaf5e", 07:18:43 INFO - "slavebuilddir": "test" 07:18:43 INFO - } 07:18:43 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:18:43 INFO - Running post-action listener: _resource_record_post_action 07:18:43 INFO - ##### 07:18:43 INFO - ##### Finished read-buildbot-config step (success) 07:18:43 INFO - ##### 07:18:43 INFO - ##### 07:18:43 INFO - ##### Running download-and-extract step. 07:18:43 INFO - ##### 07:18:43 INFO - Running pre-action listener: _resource_record_pre_action 07:18:43 INFO - Running main action method: download_and_extract 07:18:43 INFO - mkdir: /builds/slave/test/build/tests 07:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:43 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:18:43 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:18:43 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:18:43 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:18:43 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:18:44 INFO - Downloaded 1361 bytes. 07:18:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:18:44 INFO - Using the following test package requirements: 07:18:44 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:18:44 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:18:44 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:18:44 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'jsshell-linux-x86_64.zip'], 07:18:44 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:18:44 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:18:44 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:18:44 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:18:44 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:18:44 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:18:44 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:18: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:18:44 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:18:44 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:18:44 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:18:44 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:18:44 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:18:45 INFO - Downloaded 24525302 bytes. 07:18:45 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:18:45 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:18:46 INFO - Return code: 0 07:18:46 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:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:48 INFO - Downloaded 24525302 bytes. 07:18:48 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:18:48 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:18:49 INFO - Return code: 0 07:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:50 INFO - Downloaded 10833369 bytes. 07:18:50 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:18:50 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:18:50 INFO - Return code: 0 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:50 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:18:50 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:18:50 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:18:50 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:18:50 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:18:51 INFO - Downloaded 63642286 bytes. 07:18:51 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:18:51 INFO - mkdir: /builds/slave/test/properties 07:18:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:51 INFO - Contents: 07:18:51 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:18:52 INFO - Running post-action listener: _resource_record_post_action 07:18:52 INFO - Running post-action listener: set_extra_try_arguments 07:18:52 INFO - ##### 07:18:52 INFO - ##### Finished download-and-extract step (success) 07:18:52 INFO - ##### 07:18:52 INFO - ##### 07:18:52 INFO - ##### Running populate-webroot step. 07:18:52 INFO - ##### 07:18:52 INFO - Running pre-action listener: _resource_record_pre_action 07:18:52 INFO - Running main action method: populate_webroot 07:18:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:52 INFO - '--tppagecycles', 07:18:52 INFO - '7'], 07:18:52 INFO - 'tests': ['tsvgm']}}, 07:18:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['damp', 'tps']}, 07:18:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'tests': ['damp', 'tps']}, 07:18:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['dromaeo_dom']}, 07:18:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['a11yr', 07:18:52 INFO - 'ts_paint', 07:18:52 INFO - 'tpaint', 07:18:52 INFO - 'sessionrestore', 07:18:52 INFO - 'sessionrestore_no_auto_restore', 07:18:52 INFO - 'tabpaint']}, 07:18:52 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:52 INFO - 'ts_paint', 07:18:52 INFO - 'tpaint', 07:18:52 INFO - 'sessionrestore', 07:18:52 INFO - 'sessionrestore_no_auto_restore', 07:18:52 INFO - 'tabpaint']}, 07:18:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:52 INFO - 'ts_paint', 07:18:52 INFO - 'tpaint', 07:18:52 INFO - 'sessionrestore', 07:18:52 INFO - 'sessionrestore_no_auto_restore', 07:18:52 INFO - 'tabpaint']}, 07:18:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:52 INFO - 'ts_paint', 07:18:52 INFO - 'tpaint', 07:18:52 INFO - 'sessionrestore', 07:18:52 INFO - 'sessionrestore_no_auto_restore', 07:18:52 INFO - 'tabpaint']}, 07:18:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['a11yr', 07:18:52 INFO - 'ts_paint', 07:18:52 INFO - 'tpaint', 07:18:52 INFO - 'sessionrestore', 07:18:52 INFO - 'sessionrestore_no_auto_restore', 07:18:52 INFO - 'tabpaint']}, 07:18:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['a11yr', 07:18:52 INFO - 'ts_paint', 07:18:52 INFO - 'tpaint', 07:18:52 INFO - 'sessionrestore', 07:18:52 INFO - 'sessionrestore_no_auto_restore', 07:18:52 INFO - 'tabpaint']}, 07:18:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['tsvgx', 07:18:52 INFO - 'tsvgr_opacity', 07:18:52 INFO - 'tart', 07:18:52 INFO - 'tscrollx', 07:18:52 INFO - 'cart']}, 07:18:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:52 INFO - 'tsvgr_opacity', 07:18:52 INFO - 'tart', 07:18:52 INFO - 'tscrollx', 07:18:52 INFO - 'cart']}, 07:18:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'talos_options': ['--disable-e10s'], 07:18:52 INFO - 'tests': ['tp5o']}, 07:18:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'tests': ['tp5o']}, 07:18:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'talos_options': ['--disable-e10s', 07:18:52 INFO - '--xperf_path', 07:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:52 INFO - 'tests': ['tp5n']}, 07:18:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:52 INFO - 'talos_options': ['--xperf_path', 07:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:52 INFO - 'tests': ['tp5n']}}, 07:18:52 INFO - 'talos.zip': {'path': '', 07:18:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:52 INFO - Running post-action listener: _resource_record_post_action 07:18:52 INFO - ##### 07:18:52 INFO - ##### Finished populate-webroot step (success) 07:18:52 INFO - ##### 07:18:52 INFO - ##### 07:18:52 INFO - ##### Running create-virtualenv step. 07:18:52 INFO - ##### 07:18:52 INFO - Running pre-action listener: _resource_record_pre_action 07:18:52 INFO - Running main action method: create_virtualenv 07:18:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:52 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:18:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:52 INFO - Using real prefix '/usr' 07:18:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:55 INFO - Installing pip.................done. 07:18:55 INFO - Return code: 0 07:18:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:18:55 INFO - Using env: {'DISPLAY': ':0', 07:18:55 INFO - 'HOME': '/home/cltbld', 07:18:55 INFO - 'LANG': 'en_US.UTF-8', 07:18:55 INFO - 'LANGUAGE': 'en_US:en', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MAIL': '/var/mail/cltbld', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SHLVL': '1', 07:18:55 INFO - 'TERM': 'linux', 07:18:55 INFO - 'TMOUT': '86400', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - '_': '/tools/buildbot/bin/python'} 07:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:55 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:18:55 INFO - Cleaning up... 07:18:55 INFO - Return code: 0 07:18:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:18:55 INFO - Using env: {'DISPLAY': ':0', 07:18:55 INFO - 'HOME': '/home/cltbld', 07:18:55 INFO - 'LANG': 'en_US.UTF-8', 07:18:55 INFO - 'LANGUAGE': 'en_US:en', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MAIL': '/var/mail/cltbld', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SHLVL': '1', 07:18:55 INFO - 'TERM': 'linux', 07:18:55 INFO - 'TMOUT': '86400', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - '_': '/tools/buildbot/bin/python'} 07:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:55 INFO - Downloading/unpacking psutil>=3.1.1 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:57 INFO - Installing collected packages: psutil 07:18:57 INFO - Running setup.py install for psutil 07:18:57 INFO - building 'psutil._psutil_linux' extension 07:18:57 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:18:57 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:18:58 INFO - building 'psutil._psutil_posix' extension 07:18:58 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:18:58 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:18:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:58 INFO - Successfully installed psutil 07:18:58 INFO - Cleaning up... 07:18:58 INFO - Return code: 0 07:18:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:18:58 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:18:58 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:18:58 INFO - Using env: {'DISPLAY': ':0', 07:18:58 INFO - 'HOME': '/home/cltbld', 07:18:58 INFO - 'LANG': 'en_US.UTF-8', 07:18:58 INFO - 'LANGUAGE': 'en_US:en', 07:18:58 INFO - 'LOGNAME': 'cltbld', 07:18:58 INFO - 'MAIL': '/var/mail/cltbld', 07:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:58 INFO - 'MOZ_NO_REMOTE': '1', 07:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:58 INFO - 'NO_EM_RESTART': '1', 07:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:58 INFO - 'PWD': '/builds/slave/test', 07:18:58 INFO - 'SHELL': '/bin/bash', 07:18:58 INFO - 'SHLVL': '1', 07:18:58 INFO - 'TERM': 'linux', 07:18:58 INFO - 'TMOUT': '86400', 07:18:58 INFO - 'USER': 'cltbld', 07:18:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:58 INFO - '_': '/tools/buildbot/bin/python'} 07:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:19:00 INFO - Installing collected packages: mozsystemmonitor 07:19:00 INFO - Running setup.py install for mozsystemmonitor 07:19:00 INFO - Successfully installed mozsystemmonitor 07:19:00 INFO - Cleaning up... 07:19:00 INFO - Return code: 0 07:19:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:19:00 INFO - Using env: {'DISPLAY': ':0', 07:19:00 INFO - 'HOME': '/home/cltbld', 07:19:00 INFO - 'LANG': 'en_US.UTF-8', 07:19:00 INFO - 'LANGUAGE': 'en_US:en', 07:19:00 INFO - 'LOGNAME': 'cltbld', 07:19:00 INFO - 'MAIL': '/var/mail/cltbld', 07:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:00 INFO - 'MOZ_NO_REMOTE': '1', 07:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:00 INFO - 'NO_EM_RESTART': '1', 07:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:00 INFO - 'PWD': '/builds/slave/test', 07:19:00 INFO - 'SHELL': '/bin/bash', 07:19:00 INFO - 'SHLVL': '1', 07:19:00 INFO - 'TERM': 'linux', 07:19:00 INFO - 'TMOUT': '86400', 07:19:00 INFO - 'USER': 'cltbld', 07:19:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:00 INFO - '_': '/tools/buildbot/bin/python'} 07:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:00 INFO - Downloading/unpacking jsonschema==2.5.1 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:19:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:19:03 INFO - warning: no files found matching '*.txt' 07:19:03 INFO - no previously-included directories found matching 'build' 07:19:03 INFO - no previously-included directories found matching 'dist' 07:19:03 INFO - no previously-included directories found matching '.git*' 07:19:03 INFO - Installing collected packages: jsonschema, functools32 07:19:03 INFO - Running setup.py install for functools32 07:19:03 INFO - warning: no files found matching '*.txt' 07:19:03 INFO - no previously-included directories found matching 'build' 07:19:03 INFO - no previously-included directories found matching 'dist' 07:19:03 INFO - no previously-included directories found matching '.git*' 07:19:03 INFO - Successfully installed jsonschema functools32 07:19:03 INFO - Cleaning up... 07:19:03 INFO - Return code: 0 07:19:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:19:03 INFO - Using env: {'DISPLAY': ':0', 07:19:03 INFO - 'HOME': '/home/cltbld', 07:19:03 INFO - 'LANG': 'en_US.UTF-8', 07:19:03 INFO - 'LANGUAGE': 'en_US:en', 07:19:03 INFO - 'LOGNAME': 'cltbld', 07:19:03 INFO - 'MAIL': '/var/mail/cltbld', 07:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:03 INFO - 'MOZ_NO_REMOTE': '1', 07:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:03 INFO - 'NO_EM_RESTART': '1', 07:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:03 INFO - 'PWD': '/builds/slave/test', 07:19:03 INFO - 'SHELL': '/bin/bash', 07:19:03 INFO - 'SHLVL': '1', 07:19:03 INFO - 'TERM': 'linux', 07:19:03 INFO - 'TMOUT': '86400', 07:19:03 INFO - 'USER': 'cltbld', 07:19:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:03 INFO - '_': '/tools/buildbot/bin/python'} 07:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:06 INFO - Downloading docopt-0.6.1.tar.gz 07:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:06 INFO - Running setup.py install for blobuploader 07:19:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:06 INFO - Running setup.py install for requests 07:19:06 INFO - Running setup.py install for docopt 07:19:06 INFO - Successfully installed blobuploader requests docopt 07:19:06 INFO - Cleaning up... 07:19:06 INFO - Return code: 0 07:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:06 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:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:06 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:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:06 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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:19:06 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:19:06 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:19:06 INFO - Using env: {'DISPLAY': ':0', 07:19:06 INFO - 'HOME': '/home/cltbld', 07:19:06 INFO - 'LANG': 'en_US.UTF-8', 07:19:06 INFO - 'LANGUAGE': 'en_US:en', 07:19:06 INFO - 'LOGNAME': 'cltbld', 07:19:06 INFO - 'MAIL': '/var/mail/cltbld', 07:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:06 INFO - 'MOZ_NO_REMOTE': '1', 07:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:06 INFO - 'NO_EM_RESTART': '1', 07:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:06 INFO - 'PWD': '/builds/slave/test', 07:19:06 INFO - 'SHELL': '/bin/bash', 07:19:06 INFO - 'SHLVL': '1', 07:19:06 INFO - 'TERM': 'linux', 07:19:06 INFO - 'TMOUT': '86400', 07:19:06 INFO - 'USER': 'cltbld', 07:19:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:06 INFO - '_': '/tools/buildbot/bin/python'} 07:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:06 INFO - Running setup.py (path:/tmp/pip-yQJIWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:07 INFO - Running setup.py (path:/tmp/pip-yRF_NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:07 INFO - Running setup.py (path:/tmp/pip-Bcd7SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:07 INFO - Running setup.py (path:/tmp/pip-y69YLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:07 INFO - Running setup.py (path:/tmp/pip-EUBEyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:07 INFO - Running setup.py (path:/tmp/pip-QGk0Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:07 INFO - Running setup.py (path:/tmp/pip-s7pD5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:07 INFO - Running setup.py (path:/tmp/pip-29aPtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:07 INFO - Running setup.py (path:/tmp/pip-MrZc6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:07 INFO - Running setup.py (path:/tmp/pip-tx_9uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:07 INFO - Running setup.py (path:/tmp/pip-QoacLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:07 INFO - Running setup.py (path:/tmp/pip-isTamR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:07 INFO - Running setup.py (path:/tmp/pip-zHRz08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:07 INFO - Running setup.py (path:/tmp/pip-rCAkHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:07 INFO - Running setup.py (path:/tmp/pip-6BE35U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:08 INFO - Running setup.py (path:/tmp/pip-OwjHBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:08 INFO - Running setup.py (path:/tmp/pip-mAnbY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:08 INFO - Running setup.py install for manifestparser 07:19:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Running setup.py install for mozcrash 07:19:08 INFO - Running setup.py install for mozdebug 07:19:08 INFO - Running setup.py install for mozdevice 07:19:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Running setup.py install for mozfile 07:19:08 INFO - Running setup.py install for mozhttpd 07:19:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Running setup.py install for mozinfo 07:19:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Running setup.py install for mozInstall 07:19:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:08 INFO - Running setup.py install for mozleak 07:19:09 INFO - Running setup.py install for mozlog 07:19:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:09 INFO - Running setup.py install for moznetwork 07:19:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:09 INFO - Running setup.py install for mozprocess 07:19:09 INFO - Running setup.py install for mozprofile 07:19:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:09 INFO - Running setup.py install for mozrunner 07:19:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:09 INFO - Running setup.py install for mozscreenshot 07:19:09 INFO - Running setup.py install for moztest 07:19:09 INFO - Running setup.py install for mozversion 07:19:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:09 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:09 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:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 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:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:19:09 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:19:09 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:19:09 INFO - Using env: {'DISPLAY': ':0', 07:19:09 INFO - 'HOME': '/home/cltbld', 07:19:09 INFO - 'LANG': 'en_US.UTF-8', 07:19:09 INFO - 'LANGUAGE': 'en_US:en', 07:19:09 INFO - 'LOGNAME': 'cltbld', 07:19:09 INFO - 'MAIL': '/var/mail/cltbld', 07:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:09 INFO - 'MOZ_NO_REMOTE': '1', 07:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:09 INFO - 'NO_EM_RESTART': '1', 07:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:09 INFO - 'PWD': '/builds/slave/test', 07:19:09 INFO - 'SHELL': '/bin/bash', 07:19:09 INFO - 'SHLVL': '1', 07:19:09 INFO - 'TERM': 'linux', 07:19:09 INFO - 'TMOUT': '86400', 07:19:09 INFO - 'USER': 'cltbld', 07:19:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:09 INFO - '_': '/tools/buildbot/bin/python'} 07:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:10 INFO - Running setup.py (path:/tmp/pip-_DSe7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:10 INFO - Running setup.py (path:/tmp/pip-qWWBXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:10 INFO - Running setup.py (path:/tmp/pip-Xhp8oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:10 INFO - Running setup.py (path:/tmp/pip-LO45HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:10 INFO - Running setup.py (path:/tmp/pip-MpKixq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:10 INFO - Running setup.py (path:/tmp/pip-7DP8lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:10 INFO - Running setup.py (path:/tmp/pip-eRF8UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:10 INFO - Running setup.py (path:/tmp/pip-Ex3UQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:10 INFO - Running setup.py (path:/tmp/pip-tb7a05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:10 INFO - Running setup.py (path:/tmp/pip-wqNOj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:10 INFO - Running setup.py (path:/tmp/pip-2itSz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:10 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:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:10 INFO - Running setup.py (path:/tmp/pip-YXftZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:11 INFO - Running setup.py (path:/tmp/pip-rltVQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:11 INFO - Running setup.py (path:/tmp/pip-IN8bc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:11 INFO - Running setup.py (path:/tmp/pip-gUsy1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:11 INFO - Running setup.py (path:/tmp/pip-dMF5GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:11 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:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:11 INFO - Running setup.py (path:/tmp/pip-4yEeJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:11 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:19:11 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:19:11 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:19:11 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:19:11 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:19:11 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:19:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:13 INFO - Downloading blessings-1.6.tar.gz 07:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:13 INFO - Installing collected packages: blessings 07:19:13 INFO - Running setup.py install for blessings 07:19:13 INFO - Successfully installed blessings 07:19:13 INFO - Cleaning up... 07:19:13 INFO - Return code: 0 07:19:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:13 INFO - Reading from file tmpfile_stdout 07:19:13 INFO - Current package versions: 07:19:13 INFO - argparse == 1.2.1 07:19:13 INFO - blessings == 1.6 07:19:13 INFO - blobuploader == 1.2.4 07:19:13 INFO - docopt == 0.6.1 07:19:13 INFO - functools32 == 3.2.3-2 07:19:13 INFO - jsonschema == 2.5.1 07:19:13 INFO - manifestparser == 1.1 07:19:13 INFO - mozInstall == 1.12 07:19:13 INFO - mozcrash == 0.17 07:19:13 INFO - mozdebug == 0.1 07:19:13 INFO - mozdevice == 0.48 07:19:13 INFO - mozfile == 1.2 07:19:13 INFO - mozhttpd == 0.7 07:19:13 INFO - mozinfo == 0.9 07:19:13 INFO - mozleak == 0.1 07:19:13 INFO - mozlog == 3.2 07:19:13 INFO - moznetwork == 0.27 07:19:13 INFO - mozprocess == 0.22 07:19:13 INFO - mozprofile == 0.28 07:19:13 INFO - mozrunner == 6.11 07:19:13 INFO - mozscreenshot == 0.1 07:19:13 INFO - mozsystemmonitor == 0.3 07:19:13 INFO - moztest == 0.7 07:19:13 INFO - mozversion == 1.4 07:19:13 INFO - psutil == 3.1.1 07:19:13 INFO - requests == 1.2.3 07:19:13 INFO - wsgiref == 0.1.2 07:19:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:13 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:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:13 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:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:13 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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:19:13 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:19:13 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:19:13 INFO - Using env: {'DISPLAY': ':0', 07:19:13 INFO - 'HOME': '/home/cltbld', 07:19:13 INFO - 'LANG': 'en_US.UTF-8', 07:19:13 INFO - 'LANGUAGE': 'en_US:en', 07:19:13 INFO - 'LOGNAME': 'cltbld', 07:19:13 INFO - 'MAIL': '/var/mail/cltbld', 07:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:13 INFO - 'MOZ_NO_REMOTE': '1', 07:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:13 INFO - 'NO_EM_RESTART': '1', 07:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:13 INFO - 'PWD': '/builds/slave/test', 07:19:13 INFO - 'SHELL': '/bin/bash', 07:19:13 INFO - 'SHLVL': '1', 07:19:13 INFO - 'TERM': 'linux', 07:19:13 INFO - 'TMOUT': '86400', 07:19:13 INFO - 'USER': 'cltbld', 07:19:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:13 INFO - '_': '/tools/buildbot/bin/python'} 07:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 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:19:13 INFO - Cleaning up... 07:19:13 INFO - Return code: 0 07:19:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:13 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:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:13 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:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:13 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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:19:13 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:19:13 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:19:13 INFO - Using env: {'DISPLAY': ':0', 07:19:13 INFO - 'HOME': '/home/cltbld', 07:19:13 INFO - 'LANG': 'en_US.UTF-8', 07:19:13 INFO - 'LANGUAGE': 'en_US:en', 07:19:13 INFO - 'LOGNAME': 'cltbld', 07:19:13 INFO - 'MAIL': '/var/mail/cltbld', 07:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:13 INFO - 'MOZ_NO_REMOTE': '1', 07:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:13 INFO - 'NO_EM_RESTART': '1', 07:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:13 INFO - 'PWD': '/builds/slave/test', 07:19:13 INFO - 'SHELL': '/bin/bash', 07:19:13 INFO - 'SHLVL': '1', 07:19:13 INFO - 'TERM': 'linux', 07:19:13 INFO - 'TMOUT': '86400', 07:19:13 INFO - 'USER': 'cltbld', 07:19:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:13 INFO - '_': '/tools/buildbot/bin/python'} 07:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:14 INFO - Cleaning up... 07:19:14 INFO - Return code: 0 07:19:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:19:14 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:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:14 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:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:14 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 0x7f1c42bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', '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:19:14 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:19:14 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:19:14 INFO - Using env: {'DISPLAY': ':0', 07:19:14 INFO - 'HOME': '/home/cltbld', 07:19:14 INFO - 'LANG': 'en_US.UTF-8', 07:19:14 INFO - 'LANGUAGE': 'en_US:en', 07:19:14 INFO - 'LOGNAME': 'cltbld', 07:19:14 INFO - 'MAIL': '/var/mail/cltbld', 07:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:14 INFO - 'MOZ_NO_REMOTE': '1', 07:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:14 INFO - 'NO_EM_RESTART': '1', 07:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:14 INFO - 'PWD': '/builds/slave/test', 07:19:14 INFO - 'SHELL': '/bin/bash', 07:19:14 INFO - 'SHLVL': '1', 07:19:14 INFO - 'TERM': 'linux', 07:19:14 INFO - 'TMOUT': '86400', 07:19:14 INFO - 'USER': 'cltbld', 07:19:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:14 INFO - '_': '/tools/buildbot/bin/python'} 07:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:14 INFO - Downloading/unpacking flake8 07:19:14 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:19:14 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:19:14 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:19:14 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:19:14 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:19:14 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:19:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:19:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:19:16 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:19:16 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:19:16 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:19:16 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:19:16 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:19:16 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:19:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:19:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:19:16 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:19:16 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:19:16 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:19:16 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:19:16 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:19:16 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:19:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:19:16 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:19:16 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:19:16 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:19:16 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:19:16 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:19:16 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:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:19:16 INFO - no previously-included directories found matching 'docs/_build' 07:19:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:19:17 INFO - Running setup.py install for pep8 07:19:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:19:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:19:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:19:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:19:17 INFO - no previously-included directories found matching 'docs/_build' 07:19:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:19:17 INFO - Cleaning up... 07:19:17 INFO - Return code: 0 07:19:17 INFO - Running post-action listener: _resource_record_post_action 07:19:17 INFO - Running post-action listener: _start_resource_monitoring 07:19:17 INFO - Starting resource monitoring. 07:19:17 INFO - ##### 07:19:17 INFO - ##### Finished create-virtualenv step (success) 07:19:17 INFO - ##### 07:19:17 INFO - ##### 07:19:17 INFO - ##### Running install step. 07:19:17 INFO - ##### 07:19:17 INFO - Running pre-action listener: _resource_record_pre_action 07:19:17 INFO - Running main action method: install 07:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:17 INFO - Reading from file tmpfile_stdout 07:19:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:17 INFO - Reading from file tmpfile_stdout 07:19:17 INFO - Output received: 07:19:17 INFO - Usage: mozinstall [options] installer 07:19:17 INFO - Options: 07:19:17 INFO - -h, --help show this help message and exit 07:19:17 INFO - -d DEST, --destination=DEST 07:19:17 INFO - Directory to install application into. [default: 07:19:17 INFO - "/builds/slave/test"] 07:19:17 INFO - --app=APP Application being installed. [default: firefox] 07:19:17 INFO - mkdir: /builds/slave/test/build/application 07:19:17 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:19:17 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:19:33 INFO - Reading from file tmpfile_stdout 07:19:33 INFO - Output received: 07:19:33 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:33 INFO - Running post-action listener: _resource_record_post_action 07:19:33 INFO - ##### 07:19:33 INFO - ##### Finished install step (success) 07:19:33 INFO - ##### 07:19:33 INFO - ##### 07:19:33 INFO - ##### Running run-tests step. 07:19:33 INFO - ##### 07:19:33 INFO - Running pre-action listener: _resource_record_pre_action 07:19:33 INFO - Running main action method: run_tests 07:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:33 INFO - Python 2.7.3 07:19:33 INFO - Return code: 0 07:19:33 INFO - grabbing minidump binary from tooltool 07:19: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:19:33 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 0x2d221c0>, '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 0x2d230c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d23550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:33 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:19:33 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:19:33 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:19:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:33 INFO - Return code: 0 07:19:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:19:34 INFO - Return code: 0 07:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:19:34 INFO - Using env: {'DISPLAY': ':0', 07:19:34 INFO - 'HOME': '/home/cltbld', 07:19:34 INFO - 'LANG': 'en_US.UTF-8', 07:19:34 INFO - 'LANGUAGE': 'en_US:en', 07:19:34 INFO - 'LOGNAME': 'cltbld', 07:19:34 INFO - 'MAIL': '/var/mail/cltbld', 07:19:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:34 INFO - 'MOZ_NO_REMOTE': '1', 07:19:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:34 INFO - 'NO_EM_RESTART': '1', 07:19:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:34 INFO - 'PWD': '/builds/slave/test', 07:19:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:34 INFO - 'SHELL': '/bin/bash', 07:19:34 INFO - 'SHLVL': '1', 07:19:34 INFO - 'TERM': 'linux', 07:19:34 INFO - 'TMOUT': '86400', 07:19:34 INFO - 'USER': 'cltbld', 07:19:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867', 07:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:34 INFO - '_': '/tools/buildbot/bin/python'} 07:19:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc-5WG2dSmaZENcMBXUBaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:19:34 INFO - mozversion application_buildid: 20160708040825 07:19:34 INFO - mozversion application_changeset: dd939576757577e1580b84e0820f9eb2d77dd303 07:19:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:19:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:34 INFO - mozversion application_name: Firefox 07:19:34 INFO - mozversion application_remotingname: firefox-dev 07:19:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:34 INFO - mozversion application_vendor: Mozilla 07:19:34 INFO - mozversion application_version: 49.0a2 07:19:34 INFO - mozversion platform_buildid: 20160708040825 07:19:34 INFO - mozversion platform_changeset: dd939576757577e1580b84e0820f9eb2d77dd303 07:19:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:34 INFO - mozversion platform_version: 49.0a2 07:19:34 INFO - using testdate: 1467987574 07:19:34 INFO - actual date: 1467987574 07:19:34 INFO - starting webserver on 'localhost:41526' 07:19:34 INFO - SUITE-START | Running 2 tests 07:19:34 INFO - TEST-START | dromaeo_css 07:19:34 INFO - operating with platform_type : linux_ 07:19:34 INFO - Initialising browser for dromaeo_css test... 07:19:34 INFO - TEST-INFO | started process 29498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WATFP/profile http://localhost:41526/getInfo.html) 07:19:38 INFO - PROCESS | 29498 | __metrics Screen width/height:1600/1200 07:19:38 INFO - PROCESS | 29498 | colorDepth:24 07:19:38 INFO - PROCESS | 29498 | Browser inner width/height: 1024/697 07:19:38 INFO - PROCESS | 29498 | __metrics 07:19:39 ERROR - PROCESS | 29498 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:19:40 INFO - TEST-INFO | 29498: exit 0 07:19:40 INFO - Browser initialized. 07:19:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:40 INFO - TEST-INFO | started process 29585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WATFP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:51 INFO - PROCESS | 29585 | RSS: Main: 145321984 07:19:51 INFO - PROCESS | 29585 | 07:20:43 INFO - PROCESS | 29585 | 1467987643051 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:22:50 INFO - PROCESS | 29585 | Cycle 1(1): loaded http://localhost:41526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41526/tests/dromaeo/cssquery-ext.html) 07:22:52 INFO - PROCESS | 29585 | RSS: Main: 254570496 07:22:52 INFO - PROCESS | 29585 | 07:25:54 INFO - PROCESS | 29585 | Cycle 1(1): loaded http://localhost:41526/tests/dromaeo/cssquery-ext.html (next: http://localhost:41526/tests/dromaeo/cssquery-jquery.html) 07:25:54 INFO - PROCESS | 29585 | RSS: Main: 230125568 07:25:54 INFO - PROCESS | 29585 | 07:28:56 INFO - PROCESS | 29585 | Cycle 1(1): loaded http://localhost:41526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41526/tests/dromaeo/cssquery-mootools.html) 07:28:57 INFO - PROCESS | 29585 | RSS: Main: 222728192 07:28:57 INFO - PROCESS | 29585 | 07:31:59 INFO - PROCESS | 29585 | Cycle 1(1): loaded http://localhost:41526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41526/tests/dromaeo/cssquery-prototype.html) 07:32:00 INFO - PROCESS | 29585 | RSS: Main: 222887936 07:32:00 INFO - PROCESS | 29585 | 07:35:02 INFO - PROCESS | 29585 | Cycle 1(1): loaded http://localhost:41526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41526/tests/dromaeo/cssquery-yui.html) 07:35:03 INFO - PROCESS | 29585 | RSS: Main: 218173440 07:35:03 INFO - PROCESS | 29585 | 07:38:05 INFO - PROCESS | 29585 | Cycle 1(1): loaded http://localhost:41526/tests/dromaeo/cssquery-yui.html (next: http://localhost:41526/tests/dromaeo/cssquery-dojo.html) 07:38:06 INFO - PROCESS | 29585 | RSS: Main: 260538368 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | __start_tp_report 07:38:06 INFO - PROCESS | 29585 | _x_x_mozilla_page_load 07:38:06 INFO - PROCESS | 29585 | _x_x_mozilla_page_load_details 07:38:06 INFO - PROCESS | 29585 | |i|pagename|runs| 07:38:06 INFO - PROCESS | 29585 | |0;dojo.html;3260.771745977782;3274.9508757368644;3277.6558461361556;3304.0253125328027;3317.2038710709435;5365.7853685852515;5405.783768649254;5416.972915135429;5436.10304299791;5438.211459338394;5461.890762184764;5490.533304669098;5510.6969116698565;5513.972430137844;5521.171824226368;4920.286558449023;4952.777125029383;4979.551840334369;5015.122353588125;5084.618653600976;4857.222844344906;4993.400791904958;5034.446210916796;5038.5969122470115;5038.7984480620735;4988.077205716936;5013.273075404064;5032.295478632995;5035.823746168885;5078.64449488536;5109.003744269869;5128.2051282051525;5128.666636668642;5135.589152867799;5148.253503242027;4867.294242334877;4874.439439464471;4927.753612319406;5011.098002359574;5035.3454050973505;5372.516473517363;5375.838724838222;5410.594205434569;5420.322459692538;5428.972855135699;5924.318703349127;5928;5934.28788545373;5936.9406305937255;5940.049592065248;5826.9708651456895;5873.177755114288;5876.500497457721;5956.16613674086;5972.611780234314;5485.286912701324;5539.50144486994;5558.194061861008;5568.359638641527;5581.944180558183;5811.099279611667;6066.072950358052;6079.118527813443;6099.817005489843;6113.816585502442;5672.517835983987;5703.7433315500075;5709.029464990878;5721.8569535761935;5726.570507211975;5763.452472015152;5767.163761254678;5770.971145144332;5794.101914203306;5797.710114494258;5727.570432217601;5747.252857128547;5771.422857714195;5776.711164441761;5778.3354914184565;5777.971110144423;5858.8242352729485;5859.062549991981;5867;5901.17383566301;4536.364908912755;4537.682362234678;4538.682292239578;4543.5910768031035;4571.771411429415;4011.338129208706;4012.0772222389014;4024.215278020758;4056.8985775355263;4102.220578090213;5583.637063590853;5605.775768969277;5608.859778505488;5613.915791263134;5636.379998200195;5907.438793314628;5921.703914804242;5923.17075609415;5926.318473375531;5953.315368732565;5435.592330575223;5471.972640136773;5542.7782888684005;5546.500814926676;5605.159226116034;4995.275685025651;5019.021290848323;5024.949750502521;5027.472115427828;5044.445111037783;6070.848228794315;6114.541409394314;6128.571000029955;6130.846728831815;6131.601445906002;5757.96356655806;5825.126231065374;5849.502792262705;5870.53035757147;5925.08161234992;6107.114468402146;6136.723847426787;6149.600275982047;6158.230221222348;6158.7228574715145;5557.944420555743;5756.942430575808;5762.654240745569;5768.163616275533;5773.711314434177;5835.183074369506;5876.1773351731645;5898.764049437975;5917.437843404869;5921.319048309328;5761.855953601026;5764;5766.94233057664;5769.105788602773;5775.393583673654;5493.862653433696;5722.7710891563875;5748.051571490824;5760.452756988079;5761.135829625589;5663.292088488939;5706.172604972338;5738.540916726735;5746.971265143815;5777.422257774189;5841.94158058414;5854.795082172274;5883.882322353615;5889.057750759858;5893.764249429974;5510.559155267489;5617.073182924772;5644.6330988485615;5733.770649174153;5770.192173095686 07:38:06 INFO - PROCESS | 29585 | |1;ext.html;610.4170517156116;633.2053273142205;667.2526770017578;672.5628341577974;676.7394553097063;33873.153171170736;45883;46463;46556.301655475196;46728.532714672845;46951.76524117383;47089.058218835686;47169.52830471694;47181.29228061582;47330.76334618322;8196.221358970888;8994.640214391433;9196.954015229949;9205.033471485498;10712.78574428511;10376.533056012497;10819.83770243443;10820.837687434656;10829.133669306437;10835.78328433431;10924.836127458095;10971.725706857313;10972.067374273196;10975;10978.396188209645;8394.748157555252;10726.946365268202;10789.730256743565;11024.50389732464;11032.117430605613;10512.789744205073;10919.12646988239;10921.399323037229;10932.56269749209;10938.234323597351;43392.56607433917;43797.78101109506;43992.3401148983;44134.77932610316;44137.33793993093;3804.961950380516;3869.7097717671286;3888.9611103888883;3899.122697393092;4222.704410691253;34602.307953840784;34881;34960.825195873855;35046.47430288548;35415.114622134395;4470.50824409318;4476.440444944382;4478.731276123411;4488.147252022138;4549.24937385331;378157;379059;379629;381110;381456;38994;67920.6603966977;68760;68831.31168688349;68905.65547172232;39216.41175382372;40972.97567560835;41131.1773764523;41201.587984119775;41274.38088428676;16337.26482308299;16565.503034908972;16574.58563535897;16584;16586.58533536647;12505.312207828474;13585;13797.24115173675;13817.585472435843;14011.299435028208;9323.673671421468;9445.102715242041;9465.52672366379;9468.857967130498;9523.952380238054;3560.2701446203464;3562.4656301554974;3598.694111000542;3613.367660659374;3639.6542328478754;1056.0864851903048;1166.8949794518535;1173.2960223865612;1239.2997956154743;1243.757467293869;34113;34423.65576344255;34699.82650086733;35149.98477945184;35415.11462213465;1200.6158029430499;1206.4751832952693;1226.3132645718426;1241.4054625832055;1266.1643315411968;17961.640767184843;17963.461096167135;18224.36214732478;18228.179731912096;18307.450776476726;592121;597629;597752;598378;599412;63440.68279658572;63551.36448635547;64017;64045.679771600844;64084.35915640877;1384.8961327900447;1385.7297826923855;1469.977950330746;1491.56744544081;1507.2162475512891;33587;34323;35437.46843797397;35524.28951420906;35525;54383.18425223546;54851.17723234234;55027;55101.44898550963;55152.72423637856;421678;423151;423991;425183;425829;30748.692513074584;31785.20536986594;31800.5229921556;31835.840820795747;31849.7260109593;52247.21629175641;52303;52716;53318.73340633272;54552.45447545474;44338.556614433444;44558.55441445674;44605.330920036875;45217;45739.54260457353;43662;43746.781266093465;43820.34269485896;44309.556904430545;44789.32816007697;43803;44552.554474456134;44627.55372446234;45196.77401612971;45350.77324613356;37747;38669.806650966566;38736.22527549489;39423.605763941996;39510.20979580335;29194.929222900446;29195.270118246364;29290;29877.402451951275;29931.85034074816 07:38:06 INFO - PROCESS | 29585 | |2;jquery.html;395.63601486632297;401.90153412413963;426.48564940108946;436.74668692158554;441.63785695729507;18502.444926652206;19502.317418890343;20220;20787.792122078776;21010.159593616238;19769.209231630717;19787.703184452246;20064.495162862808;20218.69671954918;20285.59428811423;5695.316562012565;5896.587238893279;5953.3748956359605;5962.672053037081;5963.314218864843;4229.802692145002;4239.894002649928;5719.542436605062;5824.213731146305;6501.7724379646725;6555.311692272314;6591.637459939701;6626.73493060277;6637.966810165943;6639.93360066398;6427.325130861239;6539.869202615945;6627.469802415795;6627.873261545549;6632.734690612394;3934.390169523728;5524.116141417354;5805.767769289223;5829.766809327622;5854;24275.4220975636;24396.878015609807;24401.87799061011;24537.38656533583;24677.38306542351;2287.1308902616897;2440.463098118411;2484.714257860333;2699.7975151863493;2796.356837927268;9862.50687465631;10157.441340726256;10186.847197292047;10277.17782577392;12219.900208981235;1916.3005502991448;1998.99000504998;2034.7354843870203;2064.1846470644014;2182.8690278583335;78521.60739196325;79261;80440;81177.18822811755;83527.5823620884;10441.582336706599;10716.89283107159;11295.774084518427;11693.181477296677;11713.355765432983;16465.094419806785;16585.25366358517;16681.24934377956;16716.74924876128;16732.749008764877;8485.363597730195;8691.95654021726;8704.216620504185;8749.212570868653;8837.734867953972;8905.866412003825;8919.554022298858;8936.151065648754;9010.729678109667;9071.909280907106;4581.65637577183;4731.219348807477;4768.380110585602;5002.374703162105;5028.899422011613;1838.820997118419;1930.7200455934092;2083.9687404688943;2103.905324260412;2198.51632640822;984.9162821160138;1028.7696632573725;1039.604950118965;1060.8886066963012;1097.9066779323687;18839.71740423895;19068.237270509024;19074.904625476785;19363;19659.11533980974;1052.4053909541085;1052.810494111052;1054.362110922896;1059.5655781129853;1064.0583083970741;10472.468845602896;10970;11004.339739615649;11084.944575277072;11109.722256943642;481699;483187;509978;540003;552002;85588.57205714055;89993.55003224942;93764.53117734504;95978;96374;1044.8693913260843;1053.8419237114495;1054.7257712994676;1060.1095080132725;1082.610260306289;17124.48626541206;17316.701247406243;17363.913180434018;17433.041182735073;17459.738103928707;36026.27947441089;40760.1847963045;40828;43098;45112.54887451215;60713.78572428615;61821.69089154525;62673;63094.053589197116;63202;8490;8534.957325213334;8610.182032706884;8664.35017373687;8695.130486951255;8158.510489370657;11122.277051991594;12708.428120734405;13005.934970325088;14126.78809817874;12101.273923564615;12288.75422491563;12320.938395307967;12568.057395695176;12662.683432914251;7203.891941620985;9105.907291125108;11946.581869634521;12019.939900300442;12044.939775301067;11863.288202707865;11866.703332416759;11996.58011969577;12585.93707031459;13185.208887466782;8599.226069653761;8776.824463510566;8829.16122968317;8852.070532594242;8874.600642970952;8719.040905500264;11588.246763960316;12008.279503229485;12214.938925305316;12422.937885310515 07:38:06 INFO - PROCESS | 29585 | |3;mootools.html;1405.5080721747383;1565.248680633296;1603.1984007996002;1768.5667011582163;1870.9064546772659;8157.755267341981;8945.731628051153;9198.678046268382;9212.447253164806;9512.571934262958;9292.814143717122;9325.5803488843;9379.671711490098;9389.765255868606;9406.52967351633;2172.880491572963;2380.797632201265;2403.3991502124513;2430.1008626808107;2431.3799981004818;2397.19693902542;2425.6725342078857;2427.8543287402813;2427.9028838846425;2431.902723891051;2395.700537432821;2402.6396040593963;2409.0965887792077;2432.4283793308646;2439.0487709793197;2100.5378816660386;2273.499830037389;2288.9771102289096;2311.7572654871246;2376.4890548531976;2351.1183306260154;2389.2115601851347;2389.629607410854;2392.2583998960376;2393.6170212765874;9347.01856305085;9370.437773733598;9392.67125650599;9408.623655053858;9412.435253884789;5329.813456529003;5349.518543331119;5468.890622187574;5479.6164268501225;5479.808206712746;3409.6590340965954;3505.1237190702323;3538.7699799512948;3539.2213712983103;3552.289542091592;1062.229883334584;1083.377058191543;1094.874089479712;1105.6130354375985;1134.155054484406;12435.689107772288;12516.311602861839;12523.185992910432;12536.247825130431;12558.120931534797;4818.734969576637;4853.78655336166;4894.657373983787;4945.9258111128365;5004.774785134678;10692.839607405895;10696.251262411557;10707.785844283226;10726.302790318605;10735.409552474688;5481.232627432163;5548.029094908375;5548.306461692288;5549.750261238254;5554.944450555524;4469;5015.448300686921;5036;5167.22491626259;5168.58651307902;4208.095259519218;4218.873433796991;4237.809298581571;4298.78506074695;4308.9353659695125;1322.6957799705929;1368.2816521326383;1374.5944946240884;1377.1324065838658;1385.2658091211674;905.7599736069947;986.1371300112402;1010.7978404319018;1120.9271397359146;1122.685648018556;6485;6604.636744979072;6779.389854913082;6844.1444819397575;6917.584944903322;970.8495183246608;1090.3948308688596;1097.40191595579;1136.5056200552785;1165.6269993601966;4624.468186158635;4725.905481890343;4812.1578723723205;4828.830990915371;4849.151398505247;11145.944270278596;11579.826302605468;11593.478293476814;11757.647270581896;11760.411979400995;11576.305421674726;11638.359890205951;11671.183017188885;11689.123315751352;11691.707707307385;8623.870641940375;8802.559872006374;8814.471131732116;8818.691345802867;8820.5589720515;6369.20384951881;6657.40083392497;6738.629375384401;6836.692348844414;6843.794686159423;10564.630237941636;10695.251332406657;10750.354978701303;10819.837702434312;10944.069754070993;10924.617638382937;10948.835767463654;10957.890421095686;11097.056750176325;11180.161487888277;7503.287187717158;7805.648745806338;7982.121966583555;8354.916450835657;8494.405391622528;8890.4665720057;8904.599293031699;8904.599293031959;8955.865662014945;8990.190882820578;7914.762557123296;8084.393670474856;8090.393220508367;8152.755417337489;8174.059983102019;7931.246531579491;7990.960045199737;8045.477043992122;8110.229528194812;8123.147069557612;7238;7327.780166595011;7370.852582948418;7385.409167266714;7419.4806363554035;5540.695261760642;5634.718264086861;5637.8590535236945;5707.514861236841;5718.79984200551;5565.721713914207;5576.749046292845;5602.859928501657;5619.578531610064;5686.061799803151 07:38:06 INFO - PROCESS | 29585 | |4;prototype.html;310.9595752552169;311.89863294429307;320.3385009954444;324.1782082421063;325.2876201119548;5474.42518535554;5500.532454741342;5514.40082376111;5520.365158006831;5540.5290550303225;5145.3053837731895;5285.392179899312;5289.68261904286;5334.466553344673;5430.294061771964;4096.221717873602;4212.831486740527;4243.554426785189;4255.957440425603;4272.850450234242;4201.159768046387;4249.851255206068;4255.276602977501;4265.083007153461;4268.530461649216;4096.754194748325;4213.683973701969;4232.936505952413;4237.8304867805255;4250.744955302676;4200.768957707325;4207.305794543897;4214.789260536961;4215.494140703105;4237.300845360527;3675.658384689569;3721.8697345593046;3724.3854763964187;3743.344914639927;3746.98831315546;5110.923336149961;5243.134882744343;5272.446393128705;5318.30861987943;5347.866303342409;4784.234522476422;4800.975995120037;4807.4952130026195;4812.77274295056;4822.252550854623;5681.460261275172;5689.260396148516;5711.171880077407;5725.427457254241;5728.198052272685;3837.848645406367;4070.470838790938;4118.588141185887;4124.381342798574;4146.170765846812;5973.910391344133;5989.281286245635;6016.42843929826;6040.8187754367;6064.423879731418;4120.526139493996;4129.6489798367475;4142.855000074983;4143.502779666459;4164.125533637909;4074.6757303875766;4178.770167640748;4191.7484950903045;4193.22425351311;4216.494020717472;4754.930140718311;4775.997040621439;4796.704889679767;4798.2322828348;4809.687370320918;5746.683932383676;5751.827445176651;5778.711064446761;5803.823566162689;5807.738651760681;1354.6342487528311;1360.8979326550548;1403.7192561487743;1407.5214427094836;1410.4710733474947;887.8179973105628;889.7820034091689;906.5240748607034;914.7850255190025;919.8961246504222;4951.5048495150195;4955.513345996259;4965.90068198634;4985.975070124626;5009.524095210949;5193.4027586828;5203.089459344599;5227.3465816772905;5236.371635403776;5239.685618862881;4932.309476673268;4935.457099719028;4943.184374578226;4973.602111831045;5137.871553211125;3097.6127984002;3110.9844450778055;3114.8909788157307;3138.952915706266;3140.5917230759856;6046;6126.569121292002;6128.17269668598;6165;6166.845828854225;5758.510526605201;5952;6038.698065096815;6062.514998800086;6077.480629842539;6200.968995154995;6210.5652604317265;6211.378862113753;6221.626702397871;6267.023163997065;5652.830415087554;5888.882222355443;5990.11311436896;6007.639541627516;6037.63774173551;5866.2373891393845;5911.758530708599;5925;5930.555208359304;5945.346011938596;6152.323244443018;6231.283402408781;6264.968675156595;6294.8111556653375;6307.590006649553;4071.9592804072763;4153.314703073959;4159.230542349675;4167.687423443193;4168.958310416979;5707.571932105026;5902.1441890926435;5902.734376952962;5927.466528012327;5940.346561878104;5685.289338832646;5816.32449073414;5817.720101577646;5817.94182058174;5832.50423713989;5763.02028655138;5770.480656740913;5776.249087618583;5778.219940308173;5798.477662216949;5563.108543095367;5657.943420565742;5678.375378708256;5682.545396368363;5721.8569535761935;5808.477237048686;5830.5044071254415;5847.1229315603;5857.414258574279;5870.61840980352;5469.9179512306555;5678.5457163426;5702.942970570241;5703.971480142573;5706.830099829442 07:38:06 INFO - PROCESS | 29585 | |5;yui.html;764.8049747314434;805.4321703199245;850.3409857360544;877.6928075173686;912.5118061836916;16563.42028029018;16829.83170168298;17509.64980700385;18143.546411339725;18513.90743046283;15576.45482408116;15650.921745391286;15717.37130514778;15726.685466290695;15756.369745210179;698.982525436863;794.4518282385136;834.5493433545893;836.2640876029086;837.7779888329597;839.0267289943666;841.7180244618061;844.2570537926616;844.5861527851339;844.5988155626059;878.3193025405299;879.5909901895617;880.9383343165981;881.1981097201548;882.2280504558511;718.4898721907426;732.6190381001876;854.3122786157141;871.1810897756089;877.3419935048681;646.1019183335168;646.2438946432638;646.253577118429;646.5829539946754;646.7833275852595;16511.422100226555;16521.6695666086;16536.834631653648;16568.917155414267;16580.75128873068;14407.855921440756;14454.421823127062;14525;14843.480478183212;14863.479778207711;13876.514321998682;14025.298735063308;14053.156810591398;14061.437542498288;14078.648033799236;4561.794719237642;4716.716996980193;4733.668643194977;4738.64460165489;4764.118638051971;80124.59937700332;80400.19599804044;81044.59477702573;81077.18922810814;81664.18335816625;12187;12595.685107872376;12816.871831281755;12864.61406157798;12865.807012894815;18401.723974140397;18939.147738351807;19020.524486887938;19729.112189951487;19765.60468790616;9029.729108126767;9193.080691930754;9239.815203695889;9257.21313688344;9332.160105590394;5018.5985121190215;5084.008618319393;5110.488951104934;5115.514026167508;5154.664946778523;3750.9437358439645;3827.2919509890203;3845.0964023454467;3846.11539345952;3852.441395997621;575.0942217188342;647.5111290975377;669.3005808929582;670.6110455935545;671.7480944645757;684.9965750171317;756.7389250708496;768.047620950018;771.9231671817782;811.6834434570522;11308.321500709984;11326.830097548544;11459.08327333828;11500.424978751029;11608.535658573732;792.2157064506213;801.6633014134078;814.6619153051536;820.327331588104;822.8148666549978;5153.2785410042625;5324.760385782649;5328.733563321818;5332.573394128461;5347.732613369316;102285;121187;122404;124487;125211;97179.51410242904;98160;100234;101071.49464252632;101274.4936275314;91019.54490227507;92237;92442.53778731197;92720;92953.53523232476;10290.3825770454;10319.793604127724;10366.481675916024;10414.427206503411;10605.575776968835;53165.7341713289;53527;53810.46189538055;54072;55087;70943.64528177326;81180;82116;82475.5876220639;83261.58369208116;13222.669433264246;13430.127041742255;13447.125936814076;13711.862881371058;13799.655008624462;15310.387584496495;15434.614134646274;15439.536813895602;15706.450274240804;15891.602709931882;11630.360330181582;12753.426095825896;14835.406583736529;14848.7772683412;15230.923845381145;14446.422143114158;15283.083015019134;15310.004849684736;15472.690546189238;15488.612784680474;14967.625809354853;15062.472813451915;15109;15391.538253852403;15758.76361854596;11832.230904991147;11861.288322700666;12179.269243845398;12343.876561234632;12705.745885082431;11760.70598235051;11816.291022538675;12087.576934807239;12125.27248365101;12140.635780926586 07:38:06 INFO - PROCESS | 29585 | __end_tp_report 07:38:06 INFO - PROCESS | 29585 | __start_cc_report 07:38:06 INFO - PROCESS | 29585 | _x_x_mozilla_cycle_collect,892 07:38:06 INFO - PROCESS | 29585 | __end_cc_report 07:38:06 INFO - PROCESS | 29585 | __startTimestamp1467988686007__endTimestamp 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | ------- Summary: start ------- 07:38:06 INFO - PROCESS | 29585 | Number of tests: 6 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | [#0] dojo.html Cycles:165 Average:5463.66 Median:5703.74 stddev:604.28 (10.6%) stddev-sans-first:580.89 07:38:06 INFO - PROCESS | 29585 | Values: 3260.8 3275.0 3277.7 3304.0 3317.2 5365.8 5405.8 5417.0 5436.1 5438.2 5461.9 5490.5 5510.7 5514.0 5521.2 4920.3 4952.8 4979.6 5015.1 5084.6 4857.2 4993.4 5034.4 5038.6 5038.8 4988.1 5013.3 5032.3 5035.8 5078.6 5109.0 5128.2 5128.7 5135.6 5148.3 4867.3 4874.4 4927.8 5011.1 5035.3 5372.5 5375.8 5410.6 5420.3 5429.0 5924.3 5928.0 5934.3 5936.9 5940.0 5827.0 5873.2 5876.5 5956.2 5972.6 5485.3 5539.5 5558.2 5568.4 5581.9 5811.1 6066.1 6079.1 6099.8 6113.8 5672.5 5703.7 5709.0 5721.9 5726.6 5763.5 5767.2 5771.0 5794.1 5797.7 5727.6 5747.3 5771.4 5776.7 5778.3 5778.0 5858.8 5859.1 5867.0 5901.2 4536.4 4537.7 4538.7 4543.6 4571.8 4011.3 4012.1 4024.2 4056.9 4102.2 5583.6 5605.8 5608.9 5613.9 5636.4 5907.4 5921.7 5923.2 5926.3 5953.3 5435.6 5472.0 5542.8 5546.5 5605.2 4995.3 5019.0 5024.9 5027.5 5044.4 6070.8 6114.5 6128.6 6130.8 6131.6 5758.0 5825.1 5849.5 5870.5 5925.1 6107.1 6136.7 6149.6 6158.2 6158.7 5557.9 5756.9 5762.7 5768.2 5773.7 5835.2 5876.2 5898.8 5917.4 5921.3 5761.9 5764.0 5766.9 5769.1 5775.4 5493.9 5722.8 5748.1 5760.5 5761.1 5663.3 5706.2 5738.5 5747.0 5777.4 5841.9 5854.8 5883.9 5889.1 5893.8 5510.6 5617.1 5644.6 5733.8 5770.2 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | [#1] ext.html Cycles:180 Average:63211.98 Median:21312.59 stddev:126501.49 (593.6%) stddev-sans-first:126769.04 07:38:06 INFO - PROCESS | 29585 | Values: 610.4 633.2 667.3 672.6 676.7 33873.2 45883.0 46463.0 46556.3 46728.5 46951.8 47089.1 47169.5 47181.3 47330.8 8196.2 8994.6 9197.0 9205.0 10712.8 10376.5 10819.8 10820.8 10829.1 10835.8 10924.8 10971.7 10972.1 10975.0 10978.4 8394.7 10726.9 10789.7 11024.5 11032.1 10512.8 10919.1 10921.4 10932.6 10938.2 43392.6 43797.8 43992.3 44134.8 44137.3 3805.0 3869.7 3889.0 3899.1 4222.7 34602.3 34881.0 34960.8 35046.5 35415.1 4470.5 4476.4 4478.7 4488.1 4549.2 378157.0 379059.0 379629.0 381110.0 381456.0 38994.0 67920.7 68760.0 68831.3 68905.7 39216.4 40973.0 41131.2 41201.6 41274.4 16337.3 16565.5 16574.6 16584.0 16586.6 12505.3 13585.0 13797.2 13817.6 14011.3 9323.7 9445.1 9465.5 9468.9 9524.0 3560.3 3562.5 3598.7 3613.4 3639.7 1056.1 1166.9 1173.3 1239.3 1243.8 34113.0 34423.7 34699.8 35150.0 35415.1 1200.6 1206.5 1226.3 1241.4 1266.2 17961.6 17963.5 18224.4 18228.2 18307.5 592121.0 597629.0 597752.0 598378.0 599412.0 63440.7 63551.4 64017.0 64045.7 64084.4 1384.9 1385.7 1470.0 1491.6 1507.2 33587.0 34323.0 35437.5 35524.3 35525.0 54383.2 54851.2 55027.0 55101.4 55152.7 421678.0 423151.0 423991.0 425183.0 425829.0 30748.7 31785.2 31800.5 31835.8 31849.7 52247.2 52303.0 52716.0 53318.7 54552.5 44338.6 44558.6 44605.3 45217.0 45739.5 43662.0 43746.8 43820.3 44309.6 44789.3 43803.0 44552.6 44627.6 45196.8 45350.8 37747.0 38669.8 38736.2 39423.6 39510.2 29194.9 29195.3 29290.0 29877.4 29931.9 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | [#2] jquery.html Cycles:180 Average:29951.87 Median:13581.05 stddev:84667.31 (623.4%) stddev-sans-first:84875.74 07:38:06 INFO - PROCESS | 29585 | Values: 395.6 401.9 426.5 436.7 441.6 18502.4 19502.3 20220.0 20787.8 21010.2 19769.2 19787.7 20064.5 20218.7 20285.6 5695.3 5896.6 5953.4 5962.7 5963.3 4229.8 4239.9 5719.5 5824.2 6501.8 6555.3 6591.6 6626.7 6638.0 6639.9 6427.3 6539.9 6627.5 6627.9 6632.7 3934.4 5524.1 5805.8 5829.8 5854.0 24275.4 24396.9 24401.9 24537.4 24677.4 2287.1 2440.5 2484.7 2699.8 2796.4 9862.5 10157.4 10186.8 10277.2 12219.9 1916.3 1999.0 2034.7 2064.2 2182.9 78521.6 79261.0 80440.0 81177.2 83527.6 10441.6 10716.9 11295.8 11693.2 11713.4 16465.1 16585.3 16681.2 16716.7 16732.7 8485.4 8692.0 8704.2 8749.2 8837.7 8905.9 8919.6 8936.2 9010.7 9071.9 4581.7 4731.2 4768.4 5002.4 5028.9 1838.8 1930.7 2084.0 2103.9 2198.5 984.9 1028.8 1039.6 1060.9 1097.9 18839.7 19068.2 19074.9 19363.0 19659.1 1052.4 1052.8 1054.4 1059.6 1064.1 10472.5 10970.0 11004.3 11084.9 11109.7 481699.0 483187.0 509978.0 540003.0 552002.0 85588.6 89993.6 93764.5 95978.0 96374.0 1044.9 1053.8 1054.7 1060.1 1082.6 17124.5 17316.7 17363.9 17433.0 17459.7 36026.3 40760.2 40828.0 43098.0 45112.5 60713.8 61821.7 62673.0 63094.1 63202.0 8490.0 8535.0 8610.2 8664.4 8695.1 8158.5 11122.3 12708.4 13005.9 14126.8 12101.3 12288.8 12320.9 12568.1 12662.7 7203.9 9105.9 11946.6 12019.9 12044.9 11863.3 11866.7 11996.6 12585.9 13185.2 8599.2 8776.8 8829.2 8852.1 8874.6 8719.0 11588.2 12008.3 12214.9 12422.9 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | [#3] mootools.html Cycles:180 Average:6147.14 Median:4815.45 stddev:3473.04 (72.1%) stddev-sans-first:3464.50 07:38:06 INFO - PROCESS | 29585 | Values: 1405.5 1565.2 1603.2 1768.6 1870.9 8157.8 8945.7 9198.7 9212.4 9512.6 9292.8 9325.6 9379.7 9389.8 9406.5 2172.9 2380.8 2403.4 2430.1 2431.4 2397.2 2425.7 2427.9 2427.9 2431.9 2395.7 2402.6 2409.1 2432.4 2439.0 2100.5 2273.5 2289.0 2311.8 2376.5 2351.1 2389.2 2389.6 2392.3 2393.6 9347.0 9370.4 9392.7 9408.6 9412.4 5329.8 5349.5 5468.9 5479.6 5479.8 3409.7 3505.1 3538.8 3539.2 3552.3 1062.2 1083.4 1094.9 1105.6 1134.2 12435.7 12516.3 12523.2 12536.2 12558.1 4818.7 4853.8 4894.7 4945.9 5004.8 10692.8 10696.3 10707.8 10726.3 10735.4 5481.2 5548.0 5548.3 5549.8 5554.9 4469.0 5015.4 5036.0 5167.2 5168.6 4208.1 4218.9 4237.8 4298.8 4308.9 1322.7 1368.3 1374.6 1377.1 1385.3 905.8 986.1 1010.8 1120.9 1122.7 6485.0 6604.6 6779.4 6844.1 6917.6 970.8 1090.4 1097.4 1136.5 1165.6 4624.5 4725.9 4812.2 4828.8 4849.2 11145.9 11579.8 11593.5 11757.6 11760.4 11576.3 11638.4 11671.2 11689.1 11691.7 8623.9 8802.6 8814.5 8818.7 8820.6 6369.2 6657.4 6738.6 6836.7 6843.8 10564.6 10695.3 10750.4 10819.8 10944.1 10924.6 10948.8 10957.9 11097.1 11180.2 7503.3 7805.6 7982.1 8354.9 8494.4 8890.5 8904.6 8904.6 8955.9 8990.2 7914.8 8084.4 8090.4 8152.8 8174.1 7931.2 7991.0 8045.5 8110.2 8123.1 7238.0 7327.8 7370.9 7385.4 7419.5 5540.7 5634.7 5637.9 5707.5 5718.8 5565.7 5576.7 5602.9 5619.6 5686.1 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | [#4] prototype.html Cycles:180 Average:4783.42 Median:5304.00 stddev:1437.96 (27.1%) stddev-sans-first:1402.26 07:38:06 INFO - PROCESS | 29585 | Values: 311.0 311.9 320.3 324.2 325.3 5474.4 5500.5 5514.4 5520.4 5540.5 5145.3 5285.4 5289.7 5334.5 5430.3 4096.2 4212.8 4243.6 4256.0 4272.9 4201.2 4249.9 4255.3 4265.1 4268.5 4096.8 4213.7 4232.9 4237.8 4250.7 4200.8 4207.3 4214.8 4215.5 4237.3 3675.7 3721.9 3724.4 3743.3 3747.0 5110.9 5243.1 5272.4 5318.3 5347.9 4784.2 4801.0 4807.5 4812.8 4822.3 5681.5 5689.3 5711.2 5725.4 5728.2 3837.8 4070.5 4118.6 4124.4 4146.2 5973.9 5989.3 6016.4 6040.8 6064.4 4120.5 4129.6 4142.9 4143.5 4164.1 4074.7 4178.8 4191.7 4193.2 4216.5 4754.9 4776.0 4796.7 4798.2 4809.7 5746.7 5751.8 5778.7 5803.8 5807.7 1354.6 1360.9 1403.7 1407.5 1410.5 887.8 889.8 906.5 914.8 919.9 4951.5 4955.5 4965.9 4986.0 5009.5 5193.4 5203.1 5227.3 5236.4 5239.7 4932.3 4935.5 4943.2 4973.6 5137.9 3097.6 3111.0 3114.9 3139.0 3140.6 6046.0 6126.6 6128.2 6165.0 6166.8 5758.5 5952.0 6038.7 6062.5 6077.5 6201.0 6210.6 6211.4 6221.6 6267.0 5652.8 5888.9 5990.1 6007.6 6037.6 5866.2 5911.8 5925.0 5930.6 5945.3 6152.3 6231.3 6265.0 6294.8 6307.6 4072.0 4153.3 4159.2 4167.7 4169.0 5707.6 5902.1 5902.7 5927.5 5940.3 5685.3 5816.3 5817.7 5817.9 5832.5 5763.0 5770.5 5776.2 5778.2 5798.5 5563.1 5657.9 5678.4 5682.5 5721.9 5808.5 5830.5 5847.1 5857.4 5870.6 5469.9 5678.5 5702.9 5704.0 5706.8 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - PROCESS | 29585 | [#5] yui.html Cycles:180 Average:21959.94 Median:3845.61 stddev:31162.21 (810.3%) stddev-sans-first:31208.99 07:38:06 INFO - PROCESS | 29585 | Values: 764.8 805.4 850.3 877.7 912.5 16563.4 16829.8 17509.6 18143.5 18513.9 15576.5 15650.9 15717.4 15726.7 15756.4 699.0 794.5 834.5 836.3 837.8 839.0 841.7 844.3 844.6 844.6 878.3 879.6 880.9 881.2 882.2 718.5 732.6 854.3 871.2 877.3 646.1 646.2 646.3 646.6 646.8 16511.4 16521.7 16536.8 16568.9 16580.8 14407.9 14454.4 14525.0 14843.5 14863.5 13876.5 14025.3 14053.2 14061.4 14078.6 4561.8 4716.7 4733.7 4738.6 4764.1 80124.6 80400.2 81044.6 81077.2 81664.2 12187.0 12595.7 12816.9 12864.6 12865.8 18401.7 18939.1 19020.5 19729.1 19765.6 9029.7 9193.1 9239.8 9257.2 9332.2 5018.6 5084.0 5110.5 5115.5 5154.7 3750.9 3827.3 3845.1 3846.1 3852.4 575.1 647.5 669.3 670.6 671.7 685.0 756.7 768.0 771.9 811.7 11308.3 11326.8 11459.1 11500.4 11608.5 792.2 801.7 814.7 820.3 822.8 5153.3 5324.8 5328.7 5332.6 5347.7 102285.0 121187.0 122404.0 124487.0 125211.0 97179.5 98160.0 100234.0 101071.5 101274.5 91019.5 92237.0 92442.5 92720.0 92953.5 10290.4 10319.8 10366.5 10414.4 10605.6 53165.7 53527.0 53810.5 54072.0 55087.0 70943.6 81180.0 82116.0 82475.6 83261.6 13222.7 13430.1 13447.1 13711.9 13799.7 15310.4 15434.6 15439.5 15706.5 15891.6 11630.4 12753.4 14835.4 14848.8 15230.9 14446.4 15283.1 15310.0 15472.7 15488.6 14967.6 15062.5 15109.0 15391.5 15758.8 11832.2 11861.3 12179.3 12343.9 12705.7 11760.7 11816.3 12087.6 12125.3 12140.6 07:38:06 INFO - PROCESS | 29585 | -------- Summary: end -------- 07:38:06 INFO - PROCESS | 29585 | 07:38:06 INFO - TEST-INFO | 29585: exit 0 07:38:06 INFO - TEST-OK | dromaeo_css | took 1112070ms 07:38:06 INFO - TEST-START | kraken 07:38:06 INFO - operating with platform_type : linux_ 07:38:06 INFO - Initialising browser for kraken test... 07:38:06 INFO - TEST-INFO | started process 29786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOyXYUD/profile http://localhost:41526/getInfo.html) 07:38:10 INFO - PROCESS | 29786 | __metrics Screen width/height:1600/1200 07:38:10 INFO - PROCESS | 29786 | colorDepth:24 07:38:10 INFO - PROCESS | 29786 | Browser inner width/height: 1024/697 07:38:10 INFO - PROCESS | 29786 | __metrics 07:38:11 ERROR - PROCESS | 29786 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:38:12 INFO - TEST-INFO | 29786: exit 0 07:38:12 INFO - Browser initialized. 07:38:12 INFO - Running cycle 1/1 for kraken test... 07:38:12 INFO - TEST-INFO | started process 29877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOyXYUD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:24 INFO - PROCESS | 29877 | RSS: Main: 149159936 07:38:24 INFO - PROCESS | 29877 | 07:38:26 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41526/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:27 INFO - PROCESS | 29877 | RSS: Main: 198557696 07:38:27 INFO - PROCESS | 29877 | 07:38:30 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41526/tests/kraken/driver.html?testName=audio-dft) 07:38:30 INFO - PROCESS | 29877 | RSS: Main: 195977216 07:38:30 INFO - PROCESS | 29877 | 07:38:33 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41526/tests/kraken/driver.html?testName=audio-fft) 07:38:34 INFO - PROCESS | 29877 | RSS: Main: 282374144 07:38:34 INFO - PROCESS | 29877 | 07:38:36 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41526/tests/kraken/driver.html?testName=audio-oscillator) 07:38:36 INFO - PROCESS | 29877 | RSS: Main: 190513152 07:38:36 INFO - PROCESS | 29877 | 07:38:38 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:39 INFO - PROCESS | 29877 | RSS: Main: 191508480 07:38:39 INFO - PROCESS | 29877 | 07:38:42 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41526/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:43 INFO - PROCESS | 29877 | RSS: Main: 226779136 07:38:43 INFO - PROCESS | 29877 | 07:38:46 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41526/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:47 INFO - PROCESS | 29877 | RSS: Main: 227250176 07:38:47 INFO - PROCESS | 29877 | 07:38:49 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41526/tests/kraken/driver.html?testName=json-parse-financial) 07:38:50 INFO - PROCESS | 29877 | RSS: Main: 226926592 07:38:50 INFO - PROCESS | 29877 | 07:38:51 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:52 INFO - PROCESS | 29877 | RSS: Main: 204451840 07:38:52 INFO - PROCESS | 29877 | 07:38:54 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:54 INFO - PROCESS | 29877 | RSS: Main: 207245312 07:38:54 INFO - PROCESS | 29877 | 07:38:56 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:57 INFO - PROCESS | 29877 | RSS: Main: 208863232 07:38:57 INFO - PROCESS | 29877 | 07:39:00 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:00 INFO - PROCESS | 29877 | RSS: Main: 213282816 07:39:00 INFO - PROCESS | 29877 | 07:39:03 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:03 INFO - PROCESS | 29877 | RSS: Main: 213344256 07:39:03 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:41526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41526/tests/kraken/driver.html?testName=ai-astar) 07:39:05 INFO - PROCESS | 29877 | RSS: Main: 256823296 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | __start_tp_report 07:39:05 INFO - PROCESS | 29877 | _x_x_mozilla_page_load 07:39:05 INFO - PROCESS | 29877 | _x_x_mozilla_page_load_details 07:39:05 INFO - PROCESS | 29877 | |i|pagename|runs| 07:39:05 INFO - PROCESS | 29877 | |0;ai-astar;111;104;111;109;110;109;111;110;111;109 07:39:05 INFO - PROCESS | 29877 | |1;audio-beat-detection;149;131;126;176;125;127;155;130;168;125 07:39:05 INFO - PROCESS | 29877 | |2;audio-dft;163;163;161;160;159;162;161;160;161;162 07:39:05 INFO - PROCESS | 29877 | |3;audio-fft;75;74;79;125;75;76;76;75;100;75 07:39:05 INFO - PROCESS | 29877 | |4;audio-oscillator;85;85;118;86;85;84;116;86;85;124 07:39:05 INFO - PROCESS | 29877 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;116 07:39:05 INFO - PROCESS | 29877 | |6;imaging-darkroom;147;146;146;146;147;145;146;145;146;146 07:39:05 INFO - PROCESS | 29877 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 07:39:05 INFO - PROCESS | 29877 | |8;json-parse-financial;51;49;50;51;52;52;54;51;51;51 07:39:05 INFO - PROCESS | 29877 | |9;json-stringify-tinderbox;69;70;70;70;70;69;69;70;69;70 07:39:05 INFO - PROCESS | 29877 | |10;stanford-crypto-aes;76;76;82;76;75;78;77;78;124;77 07:39:05 INFO - PROCESS | 29877 | |11;stanford-crypto-ccm;127;126;124;116;118;120;115;118;122;116 07:39:05 INFO - PROCESS | 29877 | |12;stanford-crypto-pbkdf2;154;153;150;154;154;151;156;151;152;149 07:39:05 INFO - PROCESS | 29877 | |13;stanford-crypto-sha256-iterative;65;61;61;60;61;61;62;60;59;59 07:39:05 INFO - PROCESS | 29877 | __end_tp_report 07:39:05 INFO - PROCESS | 29877 | __start_cc_report 07:39:05 INFO - PROCESS | 29877 | _x_x_mozilla_cycle_collect,1559 07:39:05 INFO - PROCESS | 29877 | __end_cc_report 07:39:05 INFO - PROCESS | 29877 | __startTimestamp1467988745805__endTimestamp 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | ------- Summary: start ------- 07:39:05 INFO - PROCESS | 29877 | Number of tests: 14 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.12 (1.9%) stddev-sans-first:2.18 07:39:05 INFO - PROCESS | 29877 | Values: 111.0 104.0 111.0 109.0 110.0 109.0 111.0 110.0 111.0 109.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:140.00 stddev:19.34 (13.8%) stddev-sans-first:20.31 07:39:05 INFO - PROCESS | 29877 | Values: 149.0 131.0 126.0 176.0 125.0 127.0 155.0 130.0 168.0 125.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.22 07:39:05 INFO - PROCESS | 29877 | Values: 163.0 163.0 161.0 160.0 159.0 162.0 161.0 160.0 161.0 162.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:16.68 (22.2%) stddev-sans-first:17.44 07:39:05 INFO - PROCESS | 29877 | Values: 75.0 74.0 79.0 125.0 75.0 76.0 76.0 75.0 100.0 75.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:16.64 (19.6%) stddev-sans-first:17.22 07:39:05 INFO - PROCESS | 29877 | Values: 85.0 85.0 118.0 86.0 85.0 84.0 116.0 86.0 85.0 124.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:39:05 INFO - PROCESS | 29877 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 07:39:05 INFO - PROCESS | 29877 | Values: 147.0 146.0 146.0 146.0 147.0 145.0 146.0 145.0 146.0 146.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:39:05 INFO - PROCESS | 29877 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.32 (2.6%) stddev-sans-first:1.39 07:39:05 INFO - PROCESS | 29877 | Values: 51.0 49.0 50.0 51.0 52.0 52.0 54.0 51.0 51.0 51.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 07:39:05 INFO - PROCESS | 29877 | Values: 69.0 70.0 70.0 70.0 70.0 69.0 69.0 70.0 69.0 70.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:77.00 stddev:14.92 (19.4%) stddev-sans-first:15.67 07:39:05 INFO - PROCESS | 29877 | Values: 76.0 76.0 82.0 76.0 75.0 78.0 77.0 78.0 124.0 77.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:121.00 stddev:4.34 (3.6%) stddev-sans-first:3.84 07:39:05 INFO - PROCESS | 29877 | Values: 127.0 126.0 124.0 116.0 118.0 120.0 115.0 118.0 122.0 116.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:153.50 stddev:2.17 (1.4%) stddev-sans-first:2.22 07:39:05 INFO - PROCESS | 29877 | Values: 154.0 153.0 150.0 154.0 154.0 151.0 156.0 151.0 152.0 149.0 07:39:05 INFO - PROCESS | 29877 | 07:39:05 INFO - PROCESS | 29877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.00 stddev:1.73 (2.8%) stddev-sans-first:1.01 07:39:05 INFO - PROCESS | 29877 | Values: 65.0 61.0 61.0 60.0 61.0 61.0 62.0 60.0 59.0 59.0 07:39:05 INFO - PROCESS | 29877 | -------- Summary: end -------- 07:39:05 INFO - PROCESS | 29877 | 07:39:06 INFO - TEST-INFO | 29877: exit 0 07:39:06 INFO - TEST-OK | kraken | took 59955ms 07:39:06 INFO - SUITE-END | took 1172s 07:39:06 INFO - Completed test suite (00:19:32) 07:39:06 INFO - javascript benchmark 07:39:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3260.771745977782, 3274.9508757368644, 3277.6558461361556, 3304.0253125328027, 3317.2038710709435, 5365.7853685852515, 5405.783768649254, 5416.972915135429, 5436.10304299791, 5438.211459338394, 5461.890762184764, 5490.533304669098, 5510.6969116698565, 5513.972430137844, 5521.171824226368, 4920.286558449023, 4952.777125029383, 4979.551840334369, 5015.122353588125, 5084.618653600976, 4857.222844344906, 4993.400791904958, 5034.446210916796, 5038.5969122470115, 5038.7984480620735, 4988.077205716936, 5013.273075404064, 5032.295478632995, 5035.823746168885, 5078.64449488536, 5109.003744269869, 5128.2051282051525, 5128.666636668642, 5135.589152867799, 5148.253503242027, 4867.294242334877, 4874.439439464471, 4927.753612319406, 5011.098002359574, 5035.3454050973505, 5372.516473517363, 5375.838724838222, 5410.594205434569, 5420.322459692538, 5428.972855135699, 5924.318703349127, 5928.0, 5934.28788545373, 5936.9406305937255, 5940.049592065248, 5826.9708651456895, 5873.177755114288, 5876.500497457721, 5956.16613674086, 5972.611780234314, 5485.286912701324, 5539.50144486994, 5558.194061861008, 5568.359638641527, 5581.944180558183, 5811.099279611667, 6066.072950358052, 6079.118527813443, 6099.817005489843, 6113.816585502442, 5672.517835983987, 5703.7433315500075, 5709.029464990878, 5721.8569535761935, 5726.570507211975, 5763.452472015152, 5767.163761254678, 5770.971145144332, 5794.101914203306, 5797.710114494258, 5727.570432217601, 5747.252857128547, 5771.422857714195, 5776.711164441761, 5778.3354914184565, 5777.971110144423, 5858.8242352729485, 5859.062549991981, 5867.0, 5901.17383566301, 4536.364908912755, 4537.682362234678, 4538.682292239578, 4543.5910768031035, 4571.771411429415, 4011.338129208706, 4012.0772222389014, 4024.215278020758, 4056.8985775355263, 4102.220578090213, 5583.637063590853, 5605.775768969277, 5608.859778505488, 5613.915791263134, 5636.379998200195, 5907.438793314628, 5921.703914804242, 5923.17075609415, 5926.318473375531, 5953.315368732565, 5435.592330575223, 5471.972640136773, 5542.7782888684005, 5546.500814926676, 5605.159226116034, 4995.275685025651, 5019.021290848323, 5024.949750502521, 5027.472115427828, 5044.445111037783, 6070.848228794315, 6114.541409394314, 6128.571000029955, 6130.846728831815, 6131.601445906002, 5757.96356655806, 5825.126231065374, 5849.502792262705, 5870.53035757147, 5925.08161234992, 6107.114468402146, 6136.723847426787, 6149.600275982047, 6158.230221222348, 6158.7228574715145, 5557.944420555743, 5756.942430575808, 5762.654240745569, 5768.163616275533, 5773.711314434177, 5835.183074369506, 5876.1773351731645, 5898.764049437975, 5917.437843404869, 5921.319048309328, 5761.855953601026, 5764.0, 5766.94233057664, 5769.105788602773, 5775.393583673654, 5493.862653433696, 5722.7710891563875, 5748.051571490824, 5760.452756988079, 5761.135829625589, 5663.292088488939, 5706.172604972338, 5738.540916726735, 5746.971265143815, 5777.422257774189, 5841.94158058414, 5854.795082172274, 5883.882322353615, 5889.057750759858, 5893.764249429974, 5510.559155267489, 5617.073182924772, 5644.6330988485615, 5733.770649174153, 5770.192173095686], "value": 5424.523914667388, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.4170517156116, 633.2053273142205, 667.2526770017578, 672.5628341577974, 676.7394553097063, 33873.153171170736, 45883.0, 46463.0, 46556.301655475196, 46728.532714672845, 46951.76524117383, 47089.058218835686, 47169.52830471694, 47181.29228061582, 47330.76334618322, 8196.221358970888, 8994.640214391433, 9196.954015229949, 9205.033471485498, 10712.78574428511, 10376.533056012497, 10819.83770243443, 10820.837687434656, 10829.133669306437, 10835.78328433431, 10924.836127458095, 10971.725706857313, 10972.067374273196, 10975.0, 10978.396188209645, 8394.748157555252, 10726.946365268202, 10789.730256743565, 11024.50389732464, 11032.117430605613, 10512.789744205073, 10919.12646988239, 10921.399323037229, 10932.56269749209, 10938.234323597351, 43392.56607433917, 43797.78101109506, 43992.3401148983, 44134.77932610316, 44137.33793993093, 3804.961950380516, 3869.7097717671286, 3888.9611103888883, 3899.122697393092, 4222.704410691253, 34602.307953840784, 34881.0, 34960.825195873855, 35046.47430288548, 35415.114622134395, 4470.50824409318, 4476.440444944382, 4478.731276123411, 4488.147252022138, 4549.24937385331, 378157.0, 379059.0, 379629.0, 381110.0, 381456.0, 38994.0, 67920.6603966977, 68760.0, 68831.31168688349, 68905.65547172232, 39216.41175382372, 40972.97567560835, 41131.1773764523, 41201.587984119775, 41274.38088428676, 16337.26482308299, 16565.503034908972, 16574.58563535897, 16584.0, 16586.58533536647, 12505.312207828474, 13585.0, 13797.24115173675, 13817.585472435843, 14011.299435028208, 9323.673671421468, 9445.102715242041, 9465.52672366379, 9468.857967130498, 9523.952380238054, 3560.2701446203464, 3562.4656301554974, 3598.694111000542, 3613.367660659374, 3639.6542328478754, 1056.0864851903048, 1166.8949794518535, 1173.2960223865612, 1239.2997956154743, 1243.757467293869, 34113.0, 34423.65576344255, 34699.82650086733, 35149.98477945184, 35415.11462213465, 1200.6158029430499, 1206.4751832952693, 1226.3132645718426, 1241.4054625832055, 1266.1643315411968, 17961.640767184843, 17963.461096167135, 18224.36214732478, 18228.179731912096, 18307.450776476726, 592121.0, 597629.0, 597752.0, 598378.0, 599412.0, 63440.68279658572, 63551.36448635547, 64017.0, 64045.679771600844, 64084.35915640877, 1384.8961327900447, 1385.7297826923855, 1469.977950330746, 1491.56744544081, 1507.2162475512891, 33587.0, 34323.0, 35437.46843797397, 35524.28951420906, 35525.0, 54383.18425223546, 54851.17723234234, 55027.0, 55101.44898550963, 55152.72423637856, 421678.0, 423151.0, 423991.0, 425183.0, 425829.0, 30748.692513074584, 31785.20536986594, 31800.5229921556, 31835.840820795747, 31849.7260109593, 52247.21629175641, 52303.0, 52716.0, 53318.73340633272, 54552.45447545474, 44338.556614433444, 44558.55441445674, 44605.330920036875, 45217.0, 45739.54260457353, 43662.0, 43746.781266093465, 43820.34269485896, 44309.556904430545, 44789.32816007697, 43803.0, 44552.554474456134, 44627.55372446234, 45196.77401612971, 45350.77324613356, 37747.0, 38669.806650966566, 38736.22527549489, 39423.605763941996, 39510.20979580335, 29194.929222900446, 29195.270118246364, 29290.0, 29877.402451951275, 29931.85034074816], "value": 20684.82916504226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.63601486632297, 401.90153412413963, 426.48564940108946, 436.74668692158554, 441.63785695729507, 18502.444926652206, 19502.317418890343, 20220.0, 20787.792122078776, 21010.159593616238, 19769.209231630717, 19787.703184452246, 20064.495162862808, 20218.69671954918, 20285.59428811423, 5695.316562012565, 5896.587238893279, 5953.3748956359605, 5962.672053037081, 5963.314218864843, 4229.802692145002, 4239.894002649928, 5719.542436605062, 5824.213731146305, 6501.7724379646725, 6555.311692272314, 6591.637459939701, 6626.73493060277, 6637.966810165943, 6639.93360066398, 6427.325130861239, 6539.869202615945, 6627.469802415795, 6627.873261545549, 6632.734690612394, 3934.390169523728, 5524.116141417354, 5805.767769289223, 5829.766809327622, 5854.0, 24275.4220975636, 24396.878015609807, 24401.87799061011, 24537.38656533583, 24677.38306542351, 2287.1308902616897, 2440.463098118411, 2484.714257860333, 2699.7975151863493, 2796.356837927268, 9862.50687465631, 10157.441340726256, 10186.847197292047, 10277.17782577392, 12219.900208981235, 1916.3005502991448, 1998.99000504998, 2034.7354843870203, 2064.1846470644014, 2182.8690278583335, 78521.60739196325, 79261.0, 80440.0, 81177.18822811755, 83527.5823620884, 10441.582336706599, 10716.89283107159, 11295.774084518427, 11693.181477296677, 11713.355765432983, 16465.094419806785, 16585.25366358517, 16681.24934377956, 16716.74924876128, 16732.749008764877, 8485.363597730195, 8691.95654021726, 8704.216620504185, 8749.212570868653, 8837.734867953972, 8905.866412003825, 8919.554022298858, 8936.151065648754, 9010.729678109667, 9071.909280907106, 4581.65637577183, 4731.219348807477, 4768.380110585602, 5002.374703162105, 5028.899422011613, 1838.820997118419, 1930.7200455934092, 2083.9687404688943, 2103.905324260412, 2198.51632640822, 984.9162821160138, 1028.7696632573725, 1039.604950118965, 1060.8886066963012, 1097.9066779323687, 18839.71740423895, 19068.237270509024, 19074.904625476785, 19363.0, 19659.11533980974, 1052.4053909541085, 1052.810494111052, 1054.362110922896, 1059.5655781129853, 1064.0583083970741, 10472.468845602896, 10970.0, 11004.339739615649, 11084.944575277072, 11109.722256943642, 481699.0, 483187.0, 509978.0, 540003.0, 552002.0, 85588.57205714055, 89993.55003224942, 93764.53117734504, 95978.0, 96374.0, 1044.8693913260843, 1053.8419237114495, 1054.7257712994676, 1060.1095080132725, 1082.610260306289, 17124.48626541206, 17316.701247406243, 17363.913180434018, 17433.041182735073, 17459.738103928707, 36026.27947441089, 40760.1847963045, 40828.0, 43098.0, 45112.54887451215, 60713.78572428615, 61821.69089154525, 62673.0, 63094.053589197116, 63202.0, 8490.0, 8534.957325213334, 8610.182032706884, 8664.35017373687, 8695.130486951255, 8158.510489370657, 11122.277051991594, 12708.428120734405, 13005.934970325088, 14126.78809817874, 12101.273923564615, 12288.75422491563, 12320.938395307967, 12568.057395695176, 12662.683432914251, 7203.891941620985, 9105.907291125108, 11946.581869634521, 12019.939900300442, 12044.939775301067, 11863.288202707865, 11866.703332416759, 11996.58011969577, 12585.93707031459, 13185.208887466782, 8599.226069653761, 8776.824463510566, 8829.16122968317, 8852.070532594242, 8874.600642970952, 8719.040905500264, 11588.246763960316, 12008.279503229485, 12214.938925305316, 12422.937885310515], "value": 9501.43367342696, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.5080721747383, 1565.248680633296, 1603.1984007996002, 1768.5667011582163, 1870.9064546772659, 8157.755267341981, 8945.731628051153, 9198.678046268382, 9212.447253164806, 9512.571934262958, 9292.814143717122, 9325.5803488843, 9379.671711490098, 9389.765255868606, 9406.52967351633, 2172.880491572963, 2380.797632201265, 2403.3991502124513, 2430.1008626808107, 2431.3799981004818, 2397.19693902542, 2425.6725342078857, 2427.8543287402813, 2427.9028838846425, 2431.902723891051, 2395.700537432821, 2402.6396040593963, 2409.0965887792077, 2432.4283793308646, 2439.0487709793197, 2100.5378816660386, 2273.499830037389, 2288.9771102289096, 2311.7572654871246, 2376.4890548531976, 2351.1183306260154, 2389.2115601851347, 2389.629607410854, 2392.2583998960376, 2393.6170212765874, 9347.01856305085, 9370.437773733598, 9392.67125650599, 9408.623655053858, 9412.435253884789, 5329.813456529003, 5349.518543331119, 5468.890622187574, 5479.6164268501225, 5479.808206712746, 3409.6590340965954, 3505.1237190702323, 3538.7699799512948, 3539.2213712983103, 3552.289542091592, 1062.229883334584, 1083.377058191543, 1094.874089479712, 1105.6130354375985, 1134.155054484406, 12435.689107772288, 12516.311602861839, 12523.185992910432, 12536.247825130431, 12558.120931534797, 4818.734969576637, 4853.78655336166, 4894.657373983787, 4945.9258111128365, 5004.774785134678, 10692.839607405895, 10696.251262411557, 10707.785844283226, 10726.302790318605, 10735.409552474688, 5481.232627432163, 5548.029094908375, 5548.306461692288, 5549.750261238254, 5554.944450555524, 4469.0, 5015.448300686921, 5036.0, 5167.22491626259, 5168.58651307902, 4208.095259519218, 4218.873433796991, 4237.809298581571, 4298.78506074695, 4308.9353659695125, 1322.6957799705929, 1368.2816521326383, 1374.5944946240884, 1377.1324065838658, 1385.2658091211674, 905.7599736069947, 986.1371300112402, 1010.7978404319018, 1120.9271397359146, 1122.685648018556, 6485.0, 6604.636744979072, 6779.389854913082, 6844.1444819397575, 6917.584944903322, 970.8495183246608, 1090.3948308688596, 1097.40191595579, 1136.5056200552785, 1165.6269993601966, 4624.468186158635, 4725.905481890343, 4812.1578723723205, 4828.830990915371, 4849.151398505247, 11145.944270278596, 11579.826302605468, 11593.478293476814, 11757.647270581896, 11760.411979400995, 11576.305421674726, 11638.359890205951, 11671.183017188885, 11689.123315751352, 11691.707707307385, 8623.870641940375, 8802.559872006374, 8814.471131732116, 8818.691345802867, 8820.5589720515, 6369.20384951881, 6657.40083392497, 6738.629375384401, 6836.692348844414, 6843.794686159423, 10564.630237941636, 10695.251332406657, 10750.354978701303, 10819.837702434312, 10944.069754070993, 10924.617638382937, 10948.835767463654, 10957.890421095686, 11097.056750176325, 11180.161487888277, 7503.287187717158, 7805.648745806338, 7982.121966583555, 8354.916450835657, 8494.405391622528, 8890.4665720057, 8904.599293031699, 8904.599293031959, 8955.865662014945, 8990.190882820578, 7914.762557123296, 8084.393670474856, 8090.393220508367, 8152.755417337489, 8174.059983102019, 7931.246531579491, 7990.960045199737, 8045.477043992122, 8110.229528194812, 8123.147069557612, 7238.0, 7327.780166595011, 7370.852582948418, 7385.409167266714, 7419.4806363554035, 5540.695261760642, 5634.718264086861, 5637.8590535236945, 5707.514861236841, 5718.79984200551, 5565.721713914207, 5576.749046292845, 5602.859928501657, 5619.578531610064, 5686.061799803151], "value": 4914.808399285495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.9595752552169, 311.89863294429307, 320.3385009954444, 324.1782082421063, 325.2876201119548, 5474.42518535554, 5500.532454741342, 5514.40082376111, 5520.365158006831, 5540.5290550303225, 5145.3053837731895, 5285.392179899312, 5289.68261904286, 5334.466553344673, 5430.294061771964, 4096.221717873602, 4212.831486740527, 4243.554426785189, 4255.957440425603, 4272.850450234242, 4201.159768046387, 4249.851255206068, 4255.276602977501, 4265.083007153461, 4268.530461649216, 4096.754194748325, 4213.683973701969, 4232.936505952413, 4237.8304867805255, 4250.744955302676, 4200.768957707325, 4207.305794543897, 4214.789260536961, 4215.494140703105, 4237.300845360527, 3675.658384689569, 3721.8697345593046, 3724.3854763964187, 3743.344914639927, 3746.98831315546, 5110.923336149961, 5243.134882744343, 5272.446393128705, 5318.30861987943, 5347.866303342409, 4784.234522476422, 4800.975995120037, 4807.4952130026195, 4812.77274295056, 4822.252550854623, 5681.460261275172, 5689.260396148516, 5711.171880077407, 5725.427457254241, 5728.198052272685, 3837.848645406367, 4070.470838790938, 4118.588141185887, 4124.381342798574, 4146.170765846812, 5973.910391344133, 5989.281286245635, 6016.42843929826, 6040.8187754367, 6064.423879731418, 4120.526139493996, 4129.6489798367475, 4142.855000074983, 4143.502779666459, 4164.125533637909, 4074.6757303875766, 4178.770167640748, 4191.7484950903045, 4193.22425351311, 4216.494020717472, 4754.930140718311, 4775.997040621439, 4796.704889679767, 4798.2322828348, 4809.687370320918, 5746.683932383676, 5751.827445176651, 5778.711064446761, 5803.823566162689, 5807.738651760681, 1354.6342487528311, 1360.8979326550548, 1403.7192561487743, 1407.5214427094836, 1410.4710733474947, 887.8179973105628, 889.7820034091689, 906.5240748607034, 914.7850255190025, 919.8961246504222, 4951.5048495150195, 4955.513345996259, 4965.90068198634, 4985.975070124626, 5009.524095210949, 5193.4027586828, 5203.089459344599, 5227.3465816772905, 5236.371635403776, 5239.685618862881, 4932.309476673268, 4935.457099719028, 4943.184374578226, 4973.602111831045, 5137.871553211125, 3097.6127984002, 3110.9844450778055, 3114.8909788157307, 3138.952915706266, 3140.5917230759856, 6046.0, 6126.569121292002, 6128.17269668598, 6165.0, 6166.845828854225, 5758.510526605201, 5952.0, 6038.698065096815, 6062.514998800086, 6077.480629842539, 6200.968995154995, 6210.5652604317265, 6211.378862113753, 6221.626702397871, 6267.023163997065, 5652.830415087554, 5888.882222355443, 5990.11311436896, 6007.639541627516, 6037.63774173551, 5866.2373891393845, 5911.758530708599, 5925.0, 5930.555208359304, 5945.346011938596, 6152.323244443018, 6231.283402408781, 6264.968675156595, 6294.8111556653375, 6307.590006649553, 4071.9592804072763, 4153.314703073959, 4159.230542349675, 4167.687423443193, 4168.958310416979, 5707.571932105026, 5902.1441890926435, 5902.734376952962, 5927.466528012327, 5940.346561878104, 5685.289338832646, 5816.32449073414, 5817.720101577646, 5817.94182058174, 5832.50423713989, 5763.02028655138, 5770.480656740913, 5776.249087618583, 5778.219940308173, 5798.477662216949, 5563.108543095367, 5657.943420565742, 5678.375378708256, 5682.545396368363, 5721.8569535761935, 5808.477237048686, 5830.5044071254415, 5847.1229315603, 5857.414258574279, 5870.61840980352, 5469.9179512306555, 5678.5457163426, 5702.942970570241, 5703.971480142573, 5706.830099829442], "value": 4313.3717306086655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.8049747314434, 805.4321703199245, 850.3409857360544, 877.6928075173686, 912.5118061836916, 16563.42028029018, 16829.83170168298, 17509.64980700385, 18143.546411339725, 18513.90743046283, 15576.45482408116, 15650.921745391286, 15717.37130514778, 15726.685466290695, 15756.369745210179, 698.982525436863, 794.4518282385136, 834.5493433545893, 836.2640876029086, 837.7779888329597, 839.0267289943666, 841.7180244618061, 844.2570537926616, 844.5861527851339, 844.5988155626059, 878.3193025405299, 879.5909901895617, 880.9383343165981, 881.1981097201548, 882.2280504558511, 718.4898721907426, 732.6190381001876, 854.3122786157141, 871.1810897756089, 877.3419935048681, 646.1019183335168, 646.2438946432638, 646.253577118429, 646.5829539946754, 646.7833275852595, 16511.422100226555, 16521.6695666086, 16536.834631653648, 16568.917155414267, 16580.75128873068, 14407.855921440756, 14454.421823127062, 14525.0, 14843.480478183212, 14863.479778207711, 13876.514321998682, 14025.298735063308, 14053.156810591398, 14061.437542498288, 14078.648033799236, 4561.794719237642, 4716.716996980193, 4733.668643194977, 4738.64460165489, 4764.118638051971, 80124.59937700332, 80400.19599804044, 81044.59477702573, 81077.18922810814, 81664.18335816625, 12187.0, 12595.685107872376, 12816.871831281755, 12864.61406157798, 12865.807012894815, 18401.723974140397, 18939.147738351807, 19020.524486887938, 19729.112189951487, 19765.60468790616, 9029.729108126767, 9193.080691930754, 9239.815203695889, 9257.21313688344, 9332.160105590394, 5018.5985121190215, 5084.008618319393, 5110.488951104934, 5115.514026167508, 5154.664946778523, 3750.9437358439645, 3827.2919509890203, 3845.0964023454467, 3846.11539345952, 3852.441395997621, 575.0942217188342, 647.5111290975377, 669.3005808929582, 670.6110455935545, 671.7480944645757, 684.9965750171317, 756.7389250708496, 768.047620950018, 771.9231671817782, 811.6834434570522, 11308.321500709984, 11326.830097548544, 11459.08327333828, 11500.424978751029, 11608.535658573732, 792.2157064506213, 801.6633014134078, 814.6619153051536, 820.327331588104, 822.8148666549978, 5153.2785410042625, 5324.760385782649, 5328.733563321818, 5332.573394128461, 5347.732613369316, 102285.0, 121187.0, 122404.0, 124487.0, 125211.0, 97179.51410242904, 98160.0, 100234.0, 101071.49464252632, 101274.4936275314, 91019.54490227507, 92237.0, 92442.53778731197, 92720.0, 92953.53523232476, 10290.3825770454, 10319.793604127724, 10366.481675916024, 10414.427206503411, 10605.575776968835, 53165.7341713289, 53527.0, 53810.46189538055, 54072.0, 55087.0, 70943.64528177326, 81180.0, 82116.0, 82475.5876220639, 83261.58369208116, 13222.669433264246, 13430.127041742255, 13447.125936814076, 13711.862881371058, 13799.655008624462, 15310.387584496495, 15434.614134646274, 15439.536813895602, 15706.450274240804, 15891.602709931882, 11630.360330181582, 12753.426095825896, 14835.406583736529, 14848.7772683412, 15230.923845381145, 14446.422143114158, 15283.083015019134, 15310.004849684736, 15472.690546189238, 15488.612784680474, 14967.625809354853, 15062.472813451915, 15109.0, 15391.538253852403, 15758.76361854596, 11832.230904991147, 11861.288322700666, 12179.269243845398, 12343.876561234632, 12705.745885082431, 11760.70598235051, 11816.291022538675, 12087.576934807239, 12125.27248365101, 12140.635780926586], "value": 8086.307511620141, "unit": "score"}], "name": "dromaeo_css", "value": 7533.324505396482, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 109.0, 110.0, 109.0, 111.0, 110.0, 111.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 131.0, 126.0, 176.0, 125.0, 127.0, 155.0, 130.0, 168.0, 125.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 160.0, 159.0, 162.0, 161.0, 160.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 79.0, 125.0, 75.0, 76.0, 76.0, 75.0, 100.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 118.0, 86.0, 85.0, 84.0, 116.0, 86.0, 85.0, 124.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 51.0, 52.0, 52.0, 54.0, 51.0, 51.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 82.0, 76.0, 75.0, 78.0, 77.0, 78.0, 124.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 124.0, 116.0, 118.0, 120.0, 115.0, 118.0, 122.0, 116.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 150.0, 154.0, 154.0, 151.0, 156.0, 151.0, 152.0, 149.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 60.0, 59.0, 59.0], "value": 60.9, "unit": "score"}], "name": "kraken", "value": 1484.2000000000003, "alertThreshold": 2.0}]} 07:39:07 INFO - Return code: 0 07:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:07 ERROR - # TBPL SUCCESS # 07:39:07 INFO - Running post-action listener: _resource_record_post_action 07:39:07 INFO - ##### 07:39:07 INFO - ##### Finished run-tests step (success) 07:39:07 INFO - ##### 07:39:07 INFO - Running post-run listener: _resource_record_post_run 07:39:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 506777600; Read time: 36; Write time: 414500 07:39:07 INFO - TinderboxPrint: CPU usage
13.1% 07:39:07 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 36 07:39:07 INFO - TinderboxPrint: I/O write bytes / time
506,777,600 / 414,500 07:39:07 INFO - TinderboxPrint: CPU idle
8,249.2 (86.9%) 07:39:07 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 07:39:07 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252809216; Read time: 0; Write time: 245784 07:39:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 270336; Write bytes: 253968384; Read time: 36; Write time: 168716 07:39:07 INFO - Running post-run listener: _upload_blobber_files 07:39:07 INFO - Blob upload gear active. 07:39:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:07 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:39:07 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:39:07 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:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:11 INFO - (blobuploader) - INFO - Done attempting. 07:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:12 INFO - (blobuploader) - INFO - Done attempting. 07:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:12 INFO - (blobuploader) - INFO - Done attempting. 07:39:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:12 INFO - Return code: 0 07:39:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/734f86cb23b87cf2a3102d930f7ee15f79eb8cb0f56f49e62bf234d6c099c29a708435148942ff43746cb199cf391fa17a0252013de07482e9b22334fe4a7546", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f814b8c95f2cca5511b68b678bd2dd2aa4e58183afc809fc51145e174d7abfba2f759f42834aece15390c494ce3d6b1f7293c0681a90ee96bf7e10ea38ab1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e706751e6b85b26485debd51f882d19417eaabe26d54b9b2bddec02576496ddc96b365ff13352d53490d41a8b657a4a268bf43499f54de2ba0327b163d487d13"} 07:39:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:12 INFO - Contents: 07:39:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/734f86cb23b87cf2a3102d930f7ee15f79eb8cb0f56f49e62bf234d6c099c29a708435148942ff43746cb199cf391fa17a0252013de07482e9b22334fe4a7546", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f814b8c95f2cca5511b68b678bd2dd2aa4e58183afc809fc51145e174d7abfba2f759f42834aece15390c494ce3d6b1f7293c0681a90ee96bf7e10ea38ab1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e706751e6b85b26485debd51f882d19417eaabe26d54b9b2bddec02576496ddc96b365ff13352d53490d41a8b657a4a268bf43499f54de2ba0327b163d487d13"} 07:39:12 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:12 INFO - Copying logs to upload dir... 07:39:12 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.099056 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-08 07:39:12.836684) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:39:12.839947) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/734f86cb23b87cf2a3102d930f7ee15f79eb8cb0f56f49e62bf234d6c099c29a708435148942ff43746cb199cf391fa17a0252013de07482e9b22334fe4a7546", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f814b8c95f2cca5511b68b678bd2dd2aa4e58183afc809fc51145e174d7abfba2f759f42834aece15390c494ce3d6b1f7293c0681a90ee96bf7e10ea38ab1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e706751e6b85b26485debd51f882d19417eaabe26d54b9b2bddec02576496ddc96b365ff13352d53490d41a8b657a4a268bf43499f54de2ba0327b163d487d13"} 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.011233 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/734f86cb23b87cf2a3102d930f7ee15f79eb8cb0f56f49e62bf234d6c099c29a708435148942ff43746cb199cf391fa17a0252013de07482e9b22334fe4a7546", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f814b8c95f2cca5511b68b678bd2dd2aa4e58183afc809fc51145e174d7abfba2f759f42834aece15390c494ce3d6b1f7293c0681a90ee96bf7e10ea38ab1da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e706751e6b85b26485debd51f882d19417eaabe26d54b9b2bddec02576496ddc96b365ff13352d53490d41a8b657a4a268bf43499f54de2ba0327b163d487d13"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:39:12.866217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:39:12.866580) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467987520.976430-218448867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:39:12.952258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:39:12.952604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:39:12.952910) ========= ========= Total master_lag: 0.17 =========