builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1469872917.09 results: success (0) buildid: 20160729182925 builduid: 2dd017203036455b9f594a3790630745 revision: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.094127) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.094532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.094842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.171205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.171517) ========= 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=0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 03:01:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.5M=0.001s 2016-07-30 03:01:57 (10.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200686 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.403086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.403443) ========= 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=0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.058507 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.475231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:57.475978) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8847dd9e9a2da7a4ad074ab97e085295e50746c3 --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 8847dd9e9a2da7a4ad074ab97e085295e50746c3 --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=0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 03:01:57,572 truncating revision to first 12 chars 2016-07-30 03:01:57,572 Setting DEBUG logging. 2016-07-30 03:01:57,572 attempt 1/10 2016-07-30 03:01:57,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8847dd9e9a2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 03:01:57,939 unpacking tar archive at: mozilla-aurora-8847dd9e9a2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707586 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:58.200307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:58.200634) ========= script_repo_revision: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:58.201051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:58.201401) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:01:58.216758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-30 03:01:58.217061) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:58 INFO - MultiFileLogger online at 20160730 03:01:58 in /builds/slave/test 03:01:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:01:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:58 INFO - {'append_to_log': False, 03:01:58 INFO - 'base_work_dir': '/builds/slave/test', 03:01:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:01:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:58 INFO - 'branch': 'Mozilla-Aurora', 03:01:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:58 INFO - 'config_files': ('talos/linux_config.py',), 03:01:58 INFO - 'default_actions': ('clobber', 03:01:58 INFO - 'read-buildbot-config', 03:01:58 INFO - 'download-and-extract', 03:01:58 INFO - 'populate-webroot', 03:01:58 INFO - 'create-virtualenv', 03:01:58 INFO - 'install', 03:01:58 INFO - 'run-tests'), 03:01:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:58 INFO - 'download_minidump_stackwalk': True, 03:01:58 INFO - 'download_symbols': 'ondemand', 03:01:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:58 INFO - 'installer_path': 'installer.exe', 03:01:58 INFO - 'log_level': 'info', 03:01:58 INFO - 'log_name': 'talos', 03:01:58 INFO - 'log_to_console': True, 03:01:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:58 INFO - 'opt_config_files': (), 03:01:58 INFO - 'pip_index': False, 03:01:58 INFO - 'sps_profile': False, 03:01:58 INFO - 'sps_profile_interval': 0, 03:01:58 INFO - 'suite': 'dromaeojs-e10s', 03:01:58 INFO - 'system_bits': '32', 03:01:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:58 INFO - 'title': 'talos-linux64-ix-017', 03:01:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:58 INFO - 'use_talos_json': True, 03:01:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:58 INFO - 'work_dir': 'build'} 03:01:58 INFO - ##### 03:01:58 INFO - ##### Running clobber step. 03:01:58 INFO - ##### 03:01:58 INFO - Running pre-action listener: _resource_record_pre_action 03:01:58 INFO - Running main action method: clobber 03:01:58 INFO - rmtree: /builds/slave/test/build 03:01:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:59 INFO - Running post-action listener: _resource_record_post_action 03:01:59 INFO - ##### 03:01:59 INFO - ##### Finished clobber step (success) 03:01:59 INFO - ##### 03:01:59 INFO - ##### 03:01:59 INFO - ##### Running read-buildbot-config step. 03:01:59 INFO - ##### 03:01:59 INFO - Running pre-action listener: _resource_record_pre_action 03:01:59 INFO - Running main action method: read_buildbot_config 03:01:59 INFO - Using buildbot properties: 03:01:59 INFO - { 03:01:59 INFO - "project": "", 03:01:59 INFO - "product": "firefox", 03:01:59 INFO - "script_repo_revision": "production", 03:01:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:01:59 INFO - "repository": "", 03:01:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:01:59 INFO - "buildid": "20160729182925", 03:01:59 INFO - "pgo_build": "True", 03:01:59 INFO - "basedir": "/builds/slave/test", 03:01:59 INFO - "buildnumber": 482, 03:01:59 INFO - "slavename": "talos-linux64-ix-017", 03:01:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:01:59 INFO - "platform": "ubuntu64_hw", 03:01:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:01:59 INFO - "branch": "mozilla-aurora", 03:01:59 INFO - "repo_path": "releases/mozilla-aurora", 03:01:59 INFO - "revision": "8847dd9e9a2da7a4ad074ab97e085295e50746c3", 03:01:59 INFO - "stage_platform": "linux64-pgo", 03:01:59 INFO - "builduid": "2dd017203036455b9f594a3790630745", 03:01:59 INFO - "slavebuilddir": "test" 03:01:59 INFO - } 03:01:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:01:59 INFO - Running post-action listener: _resource_record_post_action 03:01:59 INFO - ##### 03:01:59 INFO - ##### Finished read-buildbot-config step (success) 03:01:59 INFO - ##### 03:01:59 INFO - ##### 03:01:59 INFO - ##### Running download-and-extract step. 03:01:59 INFO - ##### 03:01:59 INFO - Running pre-action listener: _resource_record_pre_action 03:01:59 INFO - Running main action method: download_and_extract 03:01:59 INFO - mkdir: /builds/slave/test/build/tests 03:01:59 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')]} 03:01:59 INFO - https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:01:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:01:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:01:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:13 INFO - Downloaded 1361 bytes. 03:02:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:02:13 INFO - Using the following test package requirements: 03:02:13 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:02:13 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:02:13 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:02:13 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'jsshell-linux-x86_64.zip'], 03:02:13 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:02:13 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:02:13 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:02:13 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:02:13 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:02:13 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:02:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:02:13 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:02: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')]} 03:02:13 INFO - https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:02:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:02:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:02:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:25 INFO - Downloaded 24495819 bytes. 03:02:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:02:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:02:26 INFO - Return code: 0 03:02:26 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 03:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:26 INFO - https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:02:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:02:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:02:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:33 INFO - Downloaded 24495819 bytes. 03:02:33 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'] 03:02:33 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 03:02:34 INFO - Return code: 0 03:02:34 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')]} 03:02:34 INFO - https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:35 INFO - Downloaded 10833369 bytes. 03:02:35 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'] 03:02:35 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 03:02:35 INFO - Return code: 0 03:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:35 INFO - https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1OtShs4TkuCRKU9u8J4NA/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 03:02:39 INFO - Downloaded 63641382 bytes. 03:02:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:02:40 INFO - mkdir: /builds/slave/test/properties 03:02:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:02:40 INFO - Writing to file /builds/slave/test/properties/build_url 03:02:40 INFO - Contents: 03:02:40 INFO - build_url:https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:02:41 INFO - Running post-action listener: _resource_record_post_action 03:02:41 INFO - Running post-action listener: set_extra_try_arguments 03:02:41 INFO - ##### 03:02:41 INFO - ##### Finished download-and-extract step (success) 03:02:41 INFO - ##### 03:02:41 INFO - ##### 03:02:41 INFO - ##### Running populate-webroot step. 03:02:41 INFO - ##### 03:02:41 INFO - Running pre-action listener: _resource_record_pre_action 03:02:41 INFO - Running main action method: populate_webroot 03:02:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:02:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:02:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:02:41 INFO - '--tppagecycles', 03:02:41 INFO - '7'], 03:02:41 INFO - 'tests': ['tsvgm']}}, 03:02:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:02:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:02:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:02:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:02:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['damp', 'tps']}, 03:02:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'tests': ['damp', 'tps']}, 03:02:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['dromaeo_dom']}, 03:02:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:02:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['a11yr', 03:02:41 INFO - 'ts_paint', 03:02:41 INFO - 'tpaint', 03:02:41 INFO - 'sessionrestore', 03:02:41 INFO - 'sessionrestore_no_auto_restore', 03:02:41 INFO - 'tabpaint']}, 03:02:41 INFO - 'other-e10s': {'tests': ['a11yr', 03:02:41 INFO - 'ts_paint', 03:02:41 INFO - 'tpaint', 03:02:41 INFO - 'sessionrestore', 03:02:41 INFO - 'sessionrestore_no_auto_restore', 03:02:41 INFO - 'tabpaint']}, 03:02:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:02:41 INFO - 'ts_paint', 03:02:41 INFO - 'tpaint', 03:02:41 INFO - 'sessionrestore', 03:02:41 INFO - 'sessionrestore_no_auto_restore', 03:02:41 INFO - 'tabpaint']}, 03:02:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:02:41 INFO - 'ts_paint', 03:02:41 INFO - 'tpaint', 03:02:41 INFO - 'sessionrestore', 03:02:41 INFO - 'sessionrestore_no_auto_restore', 03:02:41 INFO - 'tabpaint']}, 03:02:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['a11yr', 03:02:41 INFO - 'ts_paint', 03:02:41 INFO - 'tpaint', 03:02:41 INFO - 'sessionrestore', 03:02:41 INFO - 'sessionrestore_no_auto_restore', 03:02:41 INFO - 'tabpaint']}, 03:02:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['a11yr', 03:02:41 INFO - 'ts_paint', 03:02:41 INFO - 'tpaint', 03:02:41 INFO - 'sessionrestore', 03:02:41 INFO - 'sessionrestore_no_auto_restore', 03:02:41 INFO - 'tabpaint']}, 03:02:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['tsvgx', 03:02:41 INFO - 'tsvgr_opacity', 03:02:41 INFO - 'tart', 03:02:41 INFO - 'tscrollx', 03:02:41 INFO - 'cart']}, 03:02:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:02:41 INFO - 'tsvgr_opacity', 03:02:41 INFO - 'tart', 03:02:41 INFO - 'tscrollx', 03:02:41 INFO - 'cart']}, 03:02:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'talos_options': ['--disable-e10s'], 03:02:41 INFO - 'tests': ['tp5o']}, 03:02:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'tests': ['tp5o']}, 03:02:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'talos_options': ['--disable-e10s', 03:02:41 INFO - '--xperf_path', 03:02:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:41 INFO - 'tests': ['tp5n']}, 03:02:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:41 INFO - 'talos_options': ['--xperf_path', 03:02:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:41 INFO - 'tests': ['tp5n']}}, 03:02:41 INFO - 'talos.zip': {'path': '', 03:02:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:02:41 INFO - Running post-action listener: _resource_record_post_action 03:02:41 INFO - ##### 03:02:41 INFO - ##### Finished populate-webroot step (success) 03:02:41 INFO - ##### 03:02:41 INFO - ##### 03:02:41 INFO - ##### Running create-virtualenv step. 03:02:41 INFO - ##### 03:02:41 INFO - Running pre-action listener: _resource_record_pre_action 03:02:41 INFO - Running main action method: create_virtualenv 03:02:41 INFO - Creating virtualenv /builds/slave/test/build/venv 03:02:41 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 03:02:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:02:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:02:41 INFO - Using real prefix '/usr' 03:02:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:02:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:02:43 INFO - Installing pip.................done. 03:02:43 INFO - Return code: 0 03:02:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:43 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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:02:43 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 03:02:43 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 03:02:43 INFO - Using env: {'DISPLAY': ':0', 03:02:43 INFO - 'HOME': '/home/cltbld', 03:02:43 INFO - 'LANG': 'en_US.UTF-8', 03:02:43 INFO - 'LANGUAGE': 'en_US:en', 03:02:43 INFO - 'LOGNAME': 'cltbld', 03:02:43 INFO - 'MAIL': '/var/mail/cltbld', 03:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:43 INFO - 'MOZ_NO_REMOTE': '1', 03:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:43 INFO - 'NO_EM_RESTART': '1', 03:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:43 INFO - 'PWD': '/builds/slave/test', 03:02:43 INFO - 'SHELL': '/bin/bash', 03:02:43 INFO - 'SHLVL': '1', 03:02:43 INFO - 'TERM': 'linux', 03:02:43 INFO - 'TMOUT': '86400', 03:02:43 INFO - 'USER': 'cltbld', 03:02:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:43 INFO - '_': '/tools/buildbot/bin/python'} 03:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:44 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 03:02:44 INFO - Cleaning up... 03:02:44 INFO - Return code: 0 03:02:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:44 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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:02:44 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 03:02:44 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 03:02:44 INFO - Using env: {'DISPLAY': ':0', 03:02:44 INFO - 'HOME': '/home/cltbld', 03:02:44 INFO - 'LANG': 'en_US.UTF-8', 03:02:44 INFO - 'LANGUAGE': 'en_US:en', 03:02:44 INFO - 'LOGNAME': 'cltbld', 03:02:44 INFO - 'MAIL': '/var/mail/cltbld', 03:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:44 INFO - 'MOZ_NO_REMOTE': '1', 03:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:44 INFO - 'NO_EM_RESTART': '1', 03:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:44 INFO - 'PWD': '/builds/slave/test', 03:02:44 INFO - 'SHELL': '/bin/bash', 03:02:44 INFO - 'SHLVL': '1', 03:02:44 INFO - 'TERM': 'linux', 03:02:44 INFO - 'TMOUT': '86400', 03:02:44 INFO - 'USER': 'cltbld', 03:02:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:44 INFO - '_': '/tools/buildbot/bin/python'} 03:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:44 INFO - Downloading/unpacking psutil>=3.1.1 03:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:02:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:46 INFO - Installing collected packages: psutil 03:02:46 INFO - Running setup.py install for psutil 03:02:46 INFO - building 'psutil._psutil_linux' extension 03:02:46 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 03:02:47 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 03:02:47 INFO - building 'psutil._psutil_posix' extension 03:02:47 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 03:02:47 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 03:02:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:47 INFO - Successfully installed psutil 03:02:47 INFO - Cleaning up... 03:02:47 INFO - Return code: 0 03:02:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:47 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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:02:47 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 03:02:47 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 03:02:47 INFO - Using env: {'DISPLAY': ':0', 03:02:47 INFO - 'HOME': '/home/cltbld', 03:02:47 INFO - 'LANG': 'en_US.UTF-8', 03:02:47 INFO - 'LANGUAGE': 'en_US:en', 03:02:47 INFO - 'LOGNAME': 'cltbld', 03:02:47 INFO - 'MAIL': '/var/mail/cltbld', 03:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:47 INFO - 'MOZ_NO_REMOTE': '1', 03:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:47 INFO - 'NO_EM_RESTART': '1', 03:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:47 INFO - 'PWD': '/builds/slave/test', 03:02:47 INFO - 'SHELL': '/bin/bash', 03:02:47 INFO - 'SHLVL': '1', 03:02:47 INFO - 'TERM': 'linux', 03:02:47 INFO - 'TMOUT': '86400', 03:02:47 INFO - 'USER': 'cltbld', 03:02:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:47 INFO - '_': '/tools/buildbot/bin/python'} 03:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:02:48 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 03:02:48 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 03:02:48 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 03:02:48 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 03:02:48 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 03:02:48 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 03:02:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:02:50 INFO - Installing collected packages: mozsystemmonitor 03:02:50 INFO - Running setup.py install for mozsystemmonitor 03:02:50 INFO - Successfully installed mozsystemmonitor 03:02:50 INFO - Cleaning up... 03:02:50 INFO - Return code: 0 03:02:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:50 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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:02:50 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 03:02:50 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 03:02:50 INFO - Using env: {'DISPLAY': ':0', 03:02:50 INFO - 'HOME': '/home/cltbld', 03:02:50 INFO - 'LANG': 'en_US.UTF-8', 03:02:50 INFO - 'LANGUAGE': 'en_US:en', 03:02:50 INFO - 'LOGNAME': 'cltbld', 03:02:50 INFO - 'MAIL': '/var/mail/cltbld', 03:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:50 INFO - 'MOZ_NO_REMOTE': '1', 03:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:50 INFO - 'NO_EM_RESTART': '1', 03:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:50 INFO - 'PWD': '/builds/slave/test', 03:02:50 INFO - 'SHELL': '/bin/bash', 03:02:50 INFO - 'SHLVL': '1', 03:02:50 INFO - 'TERM': 'linux', 03:02:50 INFO - 'TMOUT': '86400', 03:02:50 INFO - 'USER': 'cltbld', 03:02:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:50 INFO - '_': '/tools/buildbot/bin/python'} 03:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:02:50 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 03:02:50 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 03:02:50 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 03:02:50 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 03:02:50 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 03:02:50 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 03:02:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:52 INFO - warning: no files found matching '*.txt' 03:02:52 INFO - no previously-included directories found matching 'build' 03:02:52 INFO - no previously-included directories found matching 'dist' 03:02:52 INFO - no previously-included directories found matching '.git*' 03:02:52 INFO - Installing collected packages: jsonschema, functools32 03:02:52 INFO - Running setup.py install for functools32 03:02:52 INFO - warning: no files found matching '*.txt' 03:02:52 INFO - no previously-included directories found matching 'build' 03:02:52 INFO - no previously-included directories found matching 'dist' 03:02:52 INFO - no previously-included directories found matching '.git*' 03:02:52 INFO - Successfully installed jsonschema functools32 03:02:52 INFO - Cleaning up... 03:02:52 INFO - Return code: 0 03:02:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:02:52 INFO - Using env: {'DISPLAY': ':0', 03:02:52 INFO - 'HOME': '/home/cltbld', 03:02:52 INFO - 'LANG': 'en_US.UTF-8', 03:02:52 INFO - 'LANGUAGE': 'en_US:en', 03:02:52 INFO - 'LOGNAME': 'cltbld', 03:02:52 INFO - 'MAIL': '/var/mail/cltbld', 03:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:52 INFO - 'MOZ_NO_REMOTE': '1', 03:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:52 INFO - 'NO_EM_RESTART': '1', 03:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:52 INFO - 'PWD': '/builds/slave/test', 03:02:52 INFO - 'SHELL': '/bin/bash', 03:02:52 INFO - 'SHLVL': '1', 03:02:52 INFO - 'TERM': 'linux', 03:02:52 INFO - 'TMOUT': '86400', 03:02:52 INFO - 'USER': 'cltbld', 03:02:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:52 INFO - '_': '/tools/buildbot/bin/python'} 03:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:55 INFO - Downloading docopt-0.6.1.tar.gz 03:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:55 INFO - Running setup.py install for blobuploader 03:02:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:55 INFO - Running setup.py install for requests 03:02:56 INFO - Running setup.py install for docopt 03:02:56 INFO - Successfully installed blobuploader requests docopt 03:02:56 INFO - Cleaning up... 03:02:56 INFO - Return code: 0 03:02:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:56 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')]} 03:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:56 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')]} 03:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:56 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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:02:56 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 03:02:56 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 03:02:56 INFO - Using env: {'DISPLAY': ':0', 03:02:56 INFO - 'HOME': '/home/cltbld', 03:02:56 INFO - 'LANG': 'en_US.UTF-8', 03:02:56 INFO - 'LANGUAGE': 'en_US:en', 03:02:56 INFO - 'LOGNAME': 'cltbld', 03:02:56 INFO - 'MAIL': '/var/mail/cltbld', 03:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:56 INFO - 'MOZ_NO_REMOTE': '1', 03:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:56 INFO - 'NO_EM_RESTART': '1', 03:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:56 INFO - 'PWD': '/builds/slave/test', 03:02:56 INFO - 'SHELL': '/bin/bash', 03:02:56 INFO - 'SHLVL': '1', 03:02:56 INFO - 'TERM': 'linux', 03:02:56 INFO - 'TMOUT': '86400', 03:02:56 INFO - 'USER': 'cltbld', 03:02:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:56 INFO - '_': '/tools/buildbot/bin/python'} 03:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:56 INFO - Running setup.py (path:/tmp/pip-rZT8BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:56 INFO - Running setup.py (path:/tmp/pip-LA9H8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:56 INFO - Running setup.py (path:/tmp/pip-3F8rZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:56 INFO - Running setup.py (path:/tmp/pip-rohzcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:56 INFO - Running setup.py (path:/tmp/pip-c9a1uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:56 INFO - Running setup.py (path:/tmp/pip-ei1Mjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:56 INFO - Running setup.py (path:/tmp/pip-62P9dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:56 INFO - Running setup.py (path:/tmp/pip-OVmpPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:57 INFO - Running setup.py (path:/tmp/pip-RIpIFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:57 INFO - Running setup.py (path:/tmp/pip-i9NSzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:57 INFO - Running setup.py (path:/tmp/pip-qdkg6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:57 INFO - Running setup.py (path:/tmp/pip-sdjfwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:57 INFO - Running setup.py (path:/tmp/pip-0WEyvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:57 INFO - Running setup.py (path:/tmp/pip-xqKXyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:57 INFO - Running setup.py (path:/tmp/pip-woApfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:57 INFO - Running setup.py (path:/tmp/pip-ircOcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:57 INFO - Running setup.py (path:/tmp/pip-MnBjrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:57 INFO - Running setup.py install for manifestparser 03:02:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:57 INFO - Running setup.py install for mozcrash 03:02:57 INFO - Running setup.py install for mozdebug 03:02:57 INFO - Running setup.py install for mozdevice 03:02:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Running setup.py install for mozfile 03:02:58 INFO - Running setup.py install for mozhttpd 03:02:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Running setup.py install for mozinfo 03:02:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Running setup.py install for mozInstall 03:02:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Running setup.py install for mozleak 03:02:58 INFO - Running setup.py install for mozlog 03:02:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Running setup.py install for moznetwork 03:02:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:58 INFO - Running setup.py install for mozprocess 03:02:58 INFO - Running setup.py install for mozprofile 03:02:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:59 INFO - Running setup.py install for mozrunner 03:02:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:59 INFO - Running setup.py install for mozscreenshot 03:02:59 INFO - Running setup.py install for moztest 03:02:59 INFO - Running setup.py install for mozversion 03:02:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:59 INFO - Cleaning up... 03:02:59 INFO - Return code: 0 03:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:59 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')]} 03:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:59 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')]} 03:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:59 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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:02:59 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 03:02:59 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 03:02:59 INFO - Using env: {'DISPLAY': ':0', 03:02:59 INFO - 'HOME': '/home/cltbld', 03:02:59 INFO - 'LANG': 'en_US.UTF-8', 03:02:59 INFO - 'LANGUAGE': 'en_US:en', 03:02:59 INFO - 'LOGNAME': 'cltbld', 03:02:59 INFO - 'MAIL': '/var/mail/cltbld', 03:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:59 INFO - 'MOZ_NO_REMOTE': '1', 03:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:59 INFO - 'NO_EM_RESTART': '1', 03:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:59 INFO - 'PWD': '/builds/slave/test', 03:02:59 INFO - 'SHELL': '/bin/bash', 03:02:59 INFO - 'SHLVL': '1', 03:02:59 INFO - 'TERM': 'linux', 03:02:59 INFO - 'TMOUT': '86400', 03:02:59 INFO - 'USER': 'cltbld', 03:02:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:59 INFO - '_': '/tools/buildbot/bin/python'} 03:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:59 INFO - Running setup.py (path:/tmp/pip-WpRrTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:59 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)) 03:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:59 INFO - Running setup.py (path:/tmp/pip-5_BOgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:59 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)) 03:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:59 INFO - Running setup.py (path:/tmp/pip-Bf1tEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:59 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)) 03:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:59 INFO - Running setup.py (path:/tmp/pip-8bhDX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:59 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)) 03:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:00 INFO - Running setup.py (path:/tmp/pip-jYO94W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:00 INFO - Running setup.py (path:/tmp/pip-BArKY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:00 INFO - Running setup.py (path:/tmp/pip-dmfFtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:00 INFO - Running setup.py (path:/tmp/pip-p6dzGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:00 INFO - Running setup.py (path:/tmp/pip-f9EAww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:00 INFO - Running setup.py (path:/tmp/pip-LDhMl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:00 INFO - Running setup.py (path:/tmp/pip-tHQ8QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:00 INFO - Running setup.py (path:/tmp/pip-WKDv87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:00 INFO - Running setup.py (path:/tmp/pip-6R1gWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:00 INFO - Running setup.py (path:/tmp/pip-2JJOdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:00 INFO - Running setup.py (path:/tmp/pip-2eNg0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:00 INFO - Running setup.py (path:/tmp/pip-5D7pNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:00 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)) 03:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:00 INFO - Running setup.py (path:/tmp/pip-w3zf3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:00 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)) 03:03:00 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)) 03:03:00 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)) 03:03:00 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)) 03:03:00 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)) 03:03:00 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)) 03:03:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:02 INFO - Downloading blessings-1.6.tar.gz 03:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:03:02 INFO - Installing collected packages: blessings 03:03:02 INFO - Running setup.py install for blessings 03:03:03 INFO - Successfully installed blessings 03:03:03 INFO - Cleaning up... 03:03:03 INFO - Return code: 0 03:03:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:03:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:03 INFO - Reading from file tmpfile_stdout 03:03:03 INFO - Current package versions: 03:03:03 INFO - argparse == 1.2.1 03:03:03 INFO - blessings == 1.6 03:03:03 INFO - blobuploader == 1.2.4 03:03:03 INFO - docopt == 0.6.1 03:03:03 INFO - functools32 == 3.2.3-2 03:03:03 INFO - jsonschema == 2.5.1 03:03:03 INFO - manifestparser == 1.1 03:03:03 INFO - mozInstall == 1.12 03:03:03 INFO - mozcrash == 0.17 03:03:03 INFO - mozdebug == 0.1 03:03:03 INFO - mozdevice == 0.48 03:03:03 INFO - mozfile == 1.2 03:03:03 INFO - mozhttpd == 0.7 03:03:03 INFO - mozinfo == 0.9 03:03:03 INFO - mozleak == 0.1 03:03:03 INFO - mozlog == 3.2 03:03:03 INFO - moznetwork == 0.27 03:03:03 INFO - mozprocess == 0.23 03:03:03 INFO - mozprofile == 0.28 03:03:03 INFO - mozrunner == 6.12 03:03:03 INFO - mozscreenshot == 0.1 03:03:03 INFO - mozsystemmonitor == 0.3 03:03:03 INFO - moztest == 0.7 03:03:03 INFO - mozversion == 1.4 03:03:03 INFO - psutil == 3.1.1 03:03:03 INFO - requests == 1.2.3 03:03:03 INFO - wsgiref == 0.1.2 03:03:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:03 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 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:03:03 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 03:03:03 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 03:03:03 INFO - Using env: {'DISPLAY': ':0', 03:03:03 INFO - 'HOME': '/home/cltbld', 03:03:03 INFO - 'LANG': 'en_US.UTF-8', 03:03:03 INFO - 'LANGUAGE': 'en_US:en', 03:03:03 INFO - 'LOGNAME': 'cltbld', 03:03:03 INFO - 'MAIL': '/var/mail/cltbld', 03:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:03 INFO - 'MOZ_NO_REMOTE': '1', 03:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:03 INFO - 'NO_EM_RESTART': '1', 03:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:03 INFO - 'PWD': '/builds/slave/test', 03:03:03 INFO - 'SHELL': '/bin/bash', 03:03:03 INFO - 'SHLVL': '1', 03:03:03 INFO - 'TERM': 'linux', 03:03:03 INFO - 'TMOUT': '86400', 03:03:03 INFO - 'USER': 'cltbld', 03:03:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:03 INFO - '_': '/tools/buildbot/bin/python'} 03:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 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)) 03:03:03 INFO - Cleaning up... 03:03:03 INFO - Return code: 0 03:03:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:03: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', 'jsonschema'] in /builds/slave/test/build 03:03: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 jsonschema 03:03:03 INFO - Using env: {'DISPLAY': ':0', 03:03:03 INFO - 'HOME': '/home/cltbld', 03:03:03 INFO - 'LANG': 'en_US.UTF-8', 03:03:03 INFO - 'LANGUAGE': 'en_US:en', 03:03:03 INFO - 'LOGNAME': 'cltbld', 03:03:03 INFO - 'MAIL': '/var/mail/cltbld', 03:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:03 INFO - 'MOZ_NO_REMOTE': '1', 03:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:03 INFO - 'NO_EM_RESTART': '1', 03:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:03 INFO - 'PWD': '/builds/slave/test', 03:03:03 INFO - 'SHELL': '/bin/bash', 03:03:03 INFO - 'SHLVL': '1', 03:03:03 INFO - 'TERM': 'linux', 03:03:03 INFO - 'TMOUT': '86400', 03:03:03 INFO - 'USER': 'cltbld', 03:03:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:03 INFO - '_': '/tools/buildbot/bin/python'} 03:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:03:03 INFO - Cleaning up... 03:03:03 INFO - Return code: 0 03:03:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61b9a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, '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': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', '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 03:03: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', 'flake8'] in /builds/slave/test/build 03:03: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 flake8 03:03:03 INFO - Using env: {'DISPLAY': ':0', 03:03:03 INFO - 'HOME': '/home/cltbld', 03:03:03 INFO - 'LANG': 'en_US.UTF-8', 03:03:03 INFO - 'LANGUAGE': 'en_US:en', 03:03:03 INFO - 'LOGNAME': 'cltbld', 03:03:03 INFO - 'MAIL': '/var/mail/cltbld', 03:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:03 INFO - 'MOZ_NO_REMOTE': '1', 03:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:03 INFO - 'NO_EM_RESTART': '1', 03:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:03 INFO - 'PWD': '/builds/slave/test', 03:03:03 INFO - 'SHELL': '/bin/bash', 03:03:03 INFO - 'SHLVL': '1', 03:03:03 INFO - 'TERM': 'linux', 03:03:03 INFO - 'TMOUT': '86400', 03:03:03 INFO - 'USER': 'cltbld', 03:03:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:03 INFO - '_': '/tools/buildbot/bin/python'} 03:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:03 INFO - Downloading/unpacking flake8 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:03:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:03:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 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 03:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:03:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:03:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:03:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:03:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:03:06 INFO - no previously-included directories found matching 'docs/_build' 03:03:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:03:06 INFO - Running setup.py install for pep8 03:03:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:03:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:03:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:03:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:03:06 INFO - no previously-included directories found matching 'docs/_build' 03:03:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:03:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:03:06 INFO - Cleaning up... 03:03:06 INFO - Return code: 0 03:03:06 INFO - Running post-action listener: _resource_record_post_action 03:03:06 INFO - Running post-action listener: _start_resource_monitoring 03:03:06 INFO - Starting resource monitoring. 03:03:06 INFO - ##### 03:03:06 INFO - ##### Finished create-virtualenv step (success) 03:03:06 INFO - ##### 03:03:06 INFO - ##### 03:03:06 INFO - ##### Running install step. 03:03:06 INFO - ##### 03:03:06 INFO - Running pre-action listener: _resource_record_pre_action 03:03:06 INFO - Running main action method: install 03:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:07 INFO - Reading from file tmpfile_stdout 03:03:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:03:07 INFO - Reading from file tmpfile_stdout 03:03:07 INFO - Output received: 03:03:07 INFO - Usage: mozinstall [options] installer 03:03:07 INFO - Options: 03:03:07 INFO - -h, --help show this help message and exit 03:03:07 INFO - -d DEST, --destination=DEST 03:03:07 INFO - Directory to install application into. [default: 03:03:07 INFO - "/builds/slave/test"] 03:03:07 INFO - --app=APP Application being installed. [default: firefox] 03:03:07 INFO - mkdir: /builds/slave/test/build/application 03:03:07 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'] 03:03:07 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 03:03:22 INFO - Reading from file tmpfile_stdout 03:03:22 INFO - Output received: 03:03:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:03:22 INFO - Running post-action listener: _resource_record_post_action 03:03:22 INFO - ##### 03:03:22 INFO - ##### Finished install step (success) 03:03:22 INFO - ##### 03:03:22 INFO - ##### 03:03:22 INFO - ##### Running run-tests step. 03:03:22 INFO - ##### 03:03:22 INFO - Running pre-action listener: _resource_record_pre_action 03:03:22 INFO - Running main action method: run_tests 03:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:03:22 INFO - Python 2.7.3 03:03:22 INFO - Return code: 0 03:03:22 INFO - grabbing minidump binary from tooltool 03:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:22 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 0x1c7e2e0>, '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 0x1bea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:03:22 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 03:03:22 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 03:03:22 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 03:03:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:03:23 INFO - Return code: 0 03:03:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:03:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:03:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:03:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:03:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:03:24 INFO - Return code: 0 03:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:03:24 INFO - Using env: {'DISPLAY': ':0', 03:03:24 INFO - 'HOME': '/home/cltbld', 03:03:24 INFO - 'LANG': 'en_US.UTF-8', 03:03:24 INFO - 'LANGUAGE': 'en_US:en', 03:03:24 INFO - 'LOGNAME': 'cltbld', 03:03:24 INFO - 'MAIL': '/var/mail/cltbld', 03:03:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:03:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:24 INFO - 'MOZ_NO_REMOTE': '1', 03:03:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:24 INFO - 'NO_EM_RESTART': '1', 03:03:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:24 INFO - 'PWD': '/builds/slave/test', 03:03:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:03:24 INFO - 'SHELL': '/bin/bash', 03:03:24 INFO - 'SHLVL': '1', 03:03:24 INFO - 'TERM': 'linux', 03:03:24 INFO - 'TMOUT': '86400', 03:03:24 INFO - 'USER': 'cltbld', 03:03:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598', 03:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:24 INFO - '_': '/tools/buildbot/bin/python'} 03:03:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:03:24 INFO - mozversion application_buildid: 20160729182925 03:03:24 INFO - mozversion application_changeset: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 03:03:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:03:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:03:24 INFO - mozversion application_name: Firefox 03:03:24 INFO - mozversion application_remotingname: firefox-dev 03:03:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:03:24 INFO - mozversion application_vendor: Mozilla 03:03:24 INFO - mozversion application_version: 49.0a2 03:03:24 INFO - mozversion platform_buildid: 20160729182925 03:03:24 INFO - mozversion platform_changeset: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 03:03:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:03:24 INFO - mozversion platform_version: 49.0a2 03:03:24 INFO - using testdate: 1469873004 03:03:24 INFO - actual date: 1469873004 03:03:24 INFO - starting webserver on 'localhost:49000' 03:03:24 INFO - SUITE-START | Running 2 tests 03:03:24 INFO - TEST-START | dromaeo_css 03:03:24 INFO - operating with platform_type : linux_ 03:03:24 INFO - Initialising browser for dromaeo_css test... 03:03:24 INFO - TEST-INFO | started process 3361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppj0IE7/profile http://localhost:49000/getInfo.html) 03:03:31 INFO - PROCESS | 3361 | __metrics Screen width/height:1600/1200 03:03:31 INFO - PROCESS | 3361 | colorDepth:24 03:03:31 INFO - PROCESS | 3361 | Browser inner width/height: 1024/697 03:03:31 INFO - PROCESS | 3361 | __metrics 03:03:32 ERROR - PROCESS | 3361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:03:32 INFO - TEST-INFO | 3361: exit 0 03:03:32 INFO - Browser initialized. 03:03:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:03:32 INFO - TEST-INFO | started process 3492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppj0IE7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:44 INFO - PROCESS | 3492 | RSS: Main: 155783168 03:03:44 INFO - PROCESS | 3492 | 03:04:34 INFO - PROCESS | 3492 | 1469873074304 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] 03:06:42 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49000/tests/dromaeo/cssquery-ext.html) 03:06:43 INFO - PROCESS | 3492 | RSS: Main: 159125504 03:06:43 INFO - PROCESS | 3492 | 03:09:45 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-ext.html (next: http://localhost:49000/tests/dromaeo/cssquery-jquery.html) 03:09:45 INFO - PROCESS | 3492 | RSS: Main: 157515776 03:09:45 INFO - PROCESS | 3492 | 03:12:47 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49000/tests/dromaeo/cssquery-mootools.html) 03:12:48 INFO - PROCESS | 3492 | RSS: Main: 156975104 03:12:48 INFO - PROCESS | 3492 | 03:15:49 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49000/tests/dromaeo/cssquery-prototype.html) 03:15:50 INFO - PROCESS | 3492 | RSS: Main: 156770304 03:15:50 INFO - PROCESS | 3492 | 03:18:52 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49000/tests/dromaeo/cssquery-yui.html) 03:18:53 INFO - PROCESS | 3492 | RSS: Main: 158842880 03:18:53 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:49000/tests/dromaeo/cssquery-yui.html (next: http://localhost:49000/tests/dromaeo/cssquery-dojo.html) 03:21:55 INFO - PROCESS | 3492 | RSS: Main: 159178752 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | __start_tp_report 03:21:55 INFO - PROCESS | 3492 | _x_x_mozilla_page_load 03:21:55 INFO - PROCESS | 3492 | _x_x_mozilla_page_load_details 03:21:55 INFO - PROCESS | 3492 | |i|pagename|runs| 03:21:55 INFO - PROCESS | 3492 | |0;dojo.html;3312.354090952264;3318.4026875162467;3319.30294638126;3350.63143054264;3368.00643810076;5444.646098003632;5448.727563621823;5459.12653975364;5463.235147079412;5466.835994920154;5558.527525160366;5598.188262701906;5606.691631960241;5608.831735047945;5620.437956204378;5038.496150384969;5056.949430505703;5102.158143906251;5168.534831865131;5199.6360254782185;5024.346834911456;5052.065367906949;5091.516305950947;5108.974455127719;5176.404713457944;5110.872228194287;5112.718800465973;5113.411957624865;5120.334356533645;5126.2054381570915;5122.513361230677;5178.404483484391;5190.844274671766;5194.662346947436;5238.633295669305;4923.113839508887;5094.032133894548;5109.923351149736;5137.922931156036;5174.611904107207;5366.677999320014;5370.275012873251;5378.1663842104535;5427.213054107172;5454.263674403984;5920.615160014629;5955.583109182359;5958.851028724273;5960.761569537213;5964.403559644044;5998.610090344114;6000.879982400327;6005.849853753647;6011.038233882601;6018.368071352533;5448.727563621803;5546.084895992157;5548.44515548446;5610.018246806833;5631.352394474647;6057.212562366953;6108.938910610837;6126.295476020315;6135.355787642323;6143.447089761943;5707.315122185281;5860.706964651836;5880.117982302689;5902.911456328158;5920.200772895604;5891.351951285355;5899.734511946973;5939.613925094855;5997.850053748692;6006.879862402728;5931.40685931412;5960.4635582797755;5964.194833697482;5967.433093856077;5979.103134529855;5718.828435146952;5884.882302353929;5973.522118230531;5976.760929562855;5983.282006159288;4545.659075569345;4561.521040290788;4565.155446242456;4592.494825569184;4615.792289346988;4090.836366545305;4113.218488487178;4123.36087906375;4138.627523522837;4151.584841515824;5692.715364231854;5693.686847223443;5716.228309178207;5753.194552762617;5818.4763371296785;5814.709264536841;5909.172715819789;5952.970235148883;6003.399660034049;6007.219061521974;5768.278965129359;5781.8554536136935;5788.5369170466265;5791.739371728282;5797.565182611321;5039.5968322534845;5049.343585333883;5055.039542486916;5099.107656160231;5136.049830781318;6191.597546159575;6196.1635179251125;6247.437730604267;6265.091561723524;6275.090111933744;5980.730867110903;5997.610155339889;6000.129981152796;6008.24896887889;6018;6073.514118870568;6113.749968914014;6124.295705993868;6145.985912324416;6232.937670623417;5823.505002074871;5825.50483208932;5830.650160990354;5852.268466441695;5857.26784151981;5856.648601083949;5939.970300148471;5942.64344139353;5944.524438045032;5944.970275148769;5740.1102829061565;5757.424257574209;5768.336641286138;5853.882922341614;5869.8239052828485;5805;5825.825225243249;5843.357230704534;5848.2689663792025;5856.267966504187;5524.861878453071;5709.914351284817;5721.685307308138;5731.656100633975;5761.193432919311;5841.18223448709;5844.94155058461;5872.823815285548;5890.646561206341;5916.763329466773;5758.193852860687;5766.452187042224;5800.854978625568;5810.94189058104;5812.389699081536 03:21:55 INFO - PROCESS | 3492 | |1;ext.html;591.0513625630863;637.509117979156;649.68814968815;657.2835609185988;665.2416245480154;43589;44890.55109448905;45266.321005184946;45452.545474545244;48620.51379486204;46878.53121468784;47719.52280477194;47747.28379074317;47795.761021194936;47800.76099619506;9108.726738197847;9185.265178785714;9203.585838637244;9268.21220196284;9276;8883.46699198047;8923.553822308892;8961.641534338618;8972.147645973622;9004;9038.276937844958;9098.31762617803;9101.908980910172;9107.180353768159;9107.68123115691;8931.240844528224;9000.414973026733;9004.909950900472;9033.412828166181;9078.727638170865;9051;9060.365774395796;9119.863202051974;9133;9147.085291470867;44693.10613787706;45125.77437112826;45209;45349.77325113386;45360.3195952061;3776.3202623527754;3843.7501562398356;3872.612738726105;3898.9018442234465;3956.5449973253158;33615.66384336174;33858.661413385795;33948.66051339504;34180.48729269063;34337.65662343369;4325.762083085429;4335;4337.284348082594;4367.585079417482;4438.578335058164;353091;356370;356431;357181;357401.9999999974;59880.70059649674;60370;60430.39569604336;60441.697791511644;60599.09101363395;38553.421698674545;39167.21665566673;39306.803465982484;40918;41162.79418602888;18659;18971.43085707431;19123.90438047801;19177.616447671247;19271.13279902408;14803;14994.925025375022;15048.924755376152;15119.244037798066;15135.545933622008;20706.792932070788;20774.376768696962;21062.68405973881;21100.683489747666;21171.47071323229;7731.497452665559;7802.98561187042;7836.177201393885;7921.722739704082;7988.720394786271;1083.2146693647044;1104.5802595014004;1133.2633788037676;1190.7975644140517;1199.5201919232377;32892.1776955578;32957.3408531828;33215.16962075919;33321.333573328884;33590.32819343599;1126.3748619516248;1164.8310994905692;1246.8192112143688;1253.3607859991287;1294.4822071171607;17028.48914532566;17067;17271.3955011574;17339.826601734072;17368.91315543414;633751;643705;646098;971695;980073;62644.06033909495;63782.36217637857;64179.99999999907;64232.67883660645;64314;1313.8160657507956;1331.8867896228735;1343.6237853401258;1348.157401623985;1406.1633328169723;32560.51159232661;32988.67011329952;33334;33673;33837;53075.46924530705;53459;53539.19691204557;53769.73115134399;54197.72901135469;525082;536284;536767;537094;541538;30136.698633013388;30352.696473034986;30521.779128834598;30530;30531.236719081313;50351;50891;50977;51600.74199628978;52857;41639.649599848795;41751.791241043604;42982.35526467168;43041.78479107584;43098;40572.3914141294;42708;42796;43203.35194972141;44415.11169776522;42775.3583696251;43017.569824302605;43648.78175609102;44336.11327773491;44458.777706111265;37630.811845940596;37785.433218502294;38002.429963550014;38275.61724382832;38345;29398;29562.704372956854;29846;30086.699133009264;30124.698753012188 03:21:55 INFO - PROCESS | 3492 | |2;jquery.html;426.1689705075104;429.7915510977177;432.81389002728815;435.3491530162408;436.50892745661133;18466.90766546167;19596.90201548992;20099.29652462164;20793.584128317423;20839.374818755463;19002.429927102174;19149.617007659872;19432.805671943275;20007;20026.89986550065;5635.464630860061;5799.391063938289;5804.651720896739;5811.564132690065;5832.59171857968;5570.415106413829;5700.458456446651;5744.080947048473;5768.653880767168;5782.653040817564;5693.857653558653;5711.857203569903;5719.542436605062;5719.942800572004;5729.427057294258;5513.531349835289;5713.342965558952;5722.914156287659;5766.826995190151;5776.913346299809;5086.847394578169;5154.355705536808;5177.689338639656;5237.13587258102;5240.318758561362;23358.64962025571;24180.153694620778;24284;24531.754682453124;24630.753692463026;2472.171822439485;2507.4232926427026;2555.552778263815;2782.401783616532;2853.6004959305715;14690;14826.406943722239;14959.326830292553;15188.240587970557;15241.847581524265;2078.6570215914358;2118.353902059871;2164.6428339323993;2183.563287342538;2225.054351900436;54680.45319546793;70960;71907.64046179736;76671.61664191699;77557.22442775556;10774.676759697222;11055.502502387411;11458.885411145948;11477.426128693533;12312.507499699912;15829.366825326859;15885;15919.044857308598;15974.121423321596;16015.599610009844;8386.496810191407;8454.704085356983;8498.872516912252;8577.871331930026;8761.34289928258;8294;8343.66625334992;8421.536815475207;8549.786255343666;8569.95715021421;6941.722331106699;7025;7056.082709247765;7123.465740069516;7168.068151140318;1972.859447499479;1983.5537004173946;2014.204389266261;2020.1515363547346;2031.7358743363563;452.12513785824535;475.1352538380184;480.3011618095662;496.62256684919;985.7584891701579;11916.46375913086;12086;12131.454084566216;12165.14843960932;12257.69355766113;486.69095124596134;490.825756856318;491.97540122993706;507.3708601334319;509.4726957598941;6366.77716279928;6410.775622853178;6527.706253218616;6652.301508341651;6674.699638516278;537606;544814;548434;552096;562462;78027.60986195147;100210.49894750626;100255.49872250592;100482.49758751159;100839;459.4165409929438;470.691696938499;485.98299059532746;490.49724032866595;493.75805855131443;10944.124470042536;11539.769204616028;11578;11630.302181869114;11653.941730291293;39264.0183995391;41436.37845432261;41956;42769.78615106905;43443.34834977415;59490;59703.70148149405;59808;60277.09584356326;60427.09359359701;8268.793280168044;8386.748397548083;8679.86980195285;8706.259967902546;8761.386702930733;8374.623141958748;8936.41913275635;10072.992700729868;11792.76414471723;12929.224246544862;10740.785184296426;10835.566577336818;10930.617428389969;11003.22977391575;11084;11041.503132359223;11078.5568577256;11108.333499990027;11315.943420282845;11492.885071149181;11565.108722819296;11756.70608234801;11809.704757381134;11945.343006134746;11991.460384282902;7412.814679633052;8516.70191543293;8582.841316422453;8595.484270943763;8797.164269394398;10307.381557106597;11212.159088068265;11602.88397116018;11624.593139240085;11766.823497647714 03:21:55 INFO - PROCESS | 3492 | |3;mootools.html;1443.7617793064144;1558.7739777732227;1763.1977450260133;1828.4788835181976;1881.397952655151;8351.665933362674;8403.159684031594;9337.159655630992;9695.709128726141;9720.076592723688;8761.43050701704;9009.594568244429;9203.849518810148;9219.907800921988;9231.492267925261;2420.2013335599254;2482.888270027844;2496.1887386599337;2497.438076432806;2497.500499900018;2411.6141417373224;2471.1845091119885;2482.4290413204885;2490.9252722418355;2493.1024831060804;2441.8779061046966;2457.1154384421593;2479.454520005596;2484.3789052736815;2491.750824917512;2425.0542288507495;2433.2092070077206;2457.766512181358;2458.299384675359;2475.665785119013;2359.528094381131;2364.8817559121976;2365.8343915925893;2368;2435.415500279938;8948.463092214488;8955.596998135099;8985.820283594292;9033.141851524095;9273.258139348836;5411.891762164734;5492.313460817398;5518.034343989826;5526.861828454321;5574.498295153456;3556.6621170988715;3562.3765840977726;3621.257642183346;3762.6049264827075;3801.391777315644;1215.4530461292454;1225.8099994500867;1258.7356655102349;1261.186534685123;1302.7720148973892;12849.293288869108;13123.540676076387;13129.737405251937;13181.60455186346;13196.736065278737;4912.901741965141;4947.787791990985;4971.801127954841;5080.212567052113;5100.668456550312;11356.602518911799;11386.146039047104;11398.715032124097;11449.71375715597;11451.427428628534;5370.03339398912;5376.489233522809;5397.919031214535;5398.8920221595345;5419.810306639249;4475.351074094238;4882.340883980617;4884.096442158212;4998.475160108209;5037.370328708911;4292.871213863589;4344.044310251739;4386.188555117314;4400.911981760347;4436.556344365602;1337.8729020743015;1380.8342998840203;1381.5648070857649;1381.9239941803298;1391.5199256256576;944.9244060475146;1018.6638409324905;1024.8155332040155;1028.100412139378;1030.567161792049;5949.494292985059;6032;6042.214512113397;6095.451409373089;6210.937890621036;881.4667126388571;1034.906858382734;1044.7492601775518;1049.454283772434;1078.6116997880756;4063.2889244382113;4147.419361289422;4228.217779710763;4232.534421213664;4249.575042495726;11633.76732465346;11955.760884782256;11970.940145299392;12000.699982500508;12048.698782530508;11412.258203216765;11788.997935175435;11801.291922484506;11851.407429628483;11893.04855611549;8409.705660301861;8441.324694024463;8665.783355416164;8676.8698469523;8691.348148888732;6024.759009639565;6097.695115244309;6122.663253520921;6144.692765361803;6146.815595532141;10611.09805666527;10763.192760542834;10803.837942430713;10901.83647245276;10921.180911431515;11060.834087488854;11127.554897803997;11129.944350278196;11275.548978040786;11304.378259195822;7243.311885370881;7489.28851759082;7710.498817577064;7939.166387529226;8096.595170241582;9061.818763624822;9120.49837258957;9150.816983660423;9169.862452063091;9171.266298696222;7789.922100779147;7972;8040.517568945882;8046.0747014091785;8057.476264042818;7907.920920790949;7987.520748755093;8054;8118.634661440367;8264.132266111972;7240.637968101679;7336.413086953137;7342.669579869025;7348.485606007528;7464.402847772274;5211.1922651989;5261.210818377274;5270.789168433374;5297.258383826191;5340.78636854537;5052.9494705052475;5070.923936141035;5245.9475405246985;5270.130428479258;5319.122344813062 03:21:55 INFO - PROCESS | 3492 | |4;prototype.html;338.6342749830183;339.14513735871003;340.67805923402386;351.28162906855476;354.68610279902293;5503.367112782032;5595.7202139893;5620.522255608268;5721.542276617871;5752.223449834271;5596.468335508121;5603.467670571289;5607.803726869561;5628.859278518029;5644.322681278242;4383.583559561853;4384.364267181257;4416.381706561084;4428.31361139024;4433.13553856998;4180.393842892794;4403.4495688039;4442.267025940716;4445.133199026175;4445.22208613493;4332.025294308787;4353.71700839446;4376.387305777193;4390.341448782692;4394.956050439503;4410.647148228134;4419.469663640368;4430.405054180493;4481.3726078349055;4483.730976141409;3772.3038212299625;3840.2511510255513;3912.4913761211146;3928.3910993796007;3942.0933185367526;5445.863853403657;5458.6724796512335;5459.94243223792;5464.316960379952;5487.859734703469;4952.405711314629;4986.127427700174;4988.353843231725;5040.294358789773;5084.872878178038;5787.189793428924;5841.912371314391;5872.5889187756875;5929.495992840613;5930.080837470199;4214.7681877496725;4230.894227644303;4233.491980962273;4243.787810609457;4252.2345977724;6173.228346456693;6181.342022930138;6210.192674952227;6232.937670623326;6240.188775459206;4159.396887451303;4304.677149213759;4307.375430562551;4318.417013703172;4350.608445239944;4371.366151908019;4389.122175564899;4389.166058448948;4389.4513185851765;4401.977990110029;5016.372953380827;5030.195168772979;5049.798008079709;5053.191489361684;5058.291839142523;5813.273340832396;5886.280293367323;5915.733791979371;5963.612365196248;6035.637861728311;1498.4305963733711;1502.4440956846038;1518.4078209498305;1521.8402067782945;1524.3902439024257;928.4614923344444;949.6676163342913;951.9381240219363;967.7435479597913;985.0986347491964;5214.530692237717;5227.26818245446;5233.816816411408;5257.26510251616;5279.838435544174;5410.756515956791;5464.398916119224;5500.367457742331;5502.669839809624;5503.889922201533;5047.671901326402;5206.271122042917;5213.854985286706;5219.530242278137;5251.0571088697425;2890.3496713239774;2921.605583246277;2930.809497382706;2931.8973835916067;2949.483840327934;5632.549396048306;5667.716614169275;5686.431356864363;5689.829305120853;5746.511546518509;5215.973920130375;5460.563154947595;5623.762772190112;5645.745941432645;5650.350209725934;5655;5708;5709.514691251207;5718.199452076713;5753.338366087954;5460.563154947674;5478.534324582455;5602.719864006865;5752.245565102684;6236.314005459487;6081.300650425258;6105.236845394325;6123.14276001369;6161.353057928853;6168.655910753885;6254.2807577129215;6343.238811342669;6464.935350646621;6543.901841472287;6569.638669873012;4381.846635367747;4456.442944631921;4466.419365482467;4472.776361181993;4473.4408198975125;6174.691265436621;6198.566100372931;6205.875882482234;6246.156768836331;6249.687615582264;5709;6000.939990600213;6031.69841507914;6040.275166979991;6068.969655151873;6009.36901625323;6027.21646185993;6027.30685971119;6029.728662210124;6033.366496517802;5719.2279042328755;5922.318933322551;5922.466977972003;5922.644641321534;5925.9407405925385;6033.698315084316;6035.245594300713;6035.792841431643;6048.969755151196;6051.33435322123;5918.23063001807;5934.19888315072;5941.346451890202;5958.553108516965;5969.73136208863 03:21:55 INFO - PROCESS | 3492 | |5;yui.html;805.4200975297787;814.3770015937807;834.0158612836852;848.7835601921516;891.046580159229;15570.22148892555;16278.91860540697;16450.75323870143;16549.75175372369;16579.91710041448;13301.201927884335;13371.130876493022;13378.59864204073;13463.46146154155;13477.730445391086;709.2411120101493;843.6836186430058;848.2832006954129;862.3790870573177;871.0114020586648;857.3098655582254;858.2790456016944;862.8791969124328;868.8045189832269;870.4037734152095;913.2055112052524;915.0940568836837;916.2029034739786;916.7662246127228;916.9816603667923;892.9776755581097;899.8335307968047;900.2842740021666;901.2789768185459;901.5852707754441;669.959802411852;670.6847781542667;674.6694119881272;674.8751480975986;675.1594265139884;15361.308741106564;15380.154091524962;15418.922905385401;15452.768208476882;15465.458708945245;15877.419322763606;16278.26747796352;16556.172191390502;16635.251413686412;16717.83282167175;12892;12899.35503224835;13052.869471305261;13105.737885242243;13240.53658121961;4036.8788936331957;4057.69567282455;4070.3690927906223;4108.342665173588;4154.31453810121;74511;74862.62568687122;75492;75817;76103;12479.87520124787;12565.811512827315;12613.810792838114;12657.873421265853;12740.299283539494;22426.215082472034;22522.887385562968;22543.0982760691;22558.887205563868;22675.773242267365;9248.676296329731;9336.439813611205;9344.953275233716;9363.063693630582;9421.104995025462;4973.2042873140845;5020.3724534433195;5059.139946209153;5080.085584594808;5211.452797456288;3528.135606776305;3638.181409182913;3641.1625326175126;3647.0335361129323;3660.7071434285194;625.343389441085;627.7583130494793;643.0836058616546;662.6719773712043;666.4634968850025;670.1187937861696;745.6271864067966;749.688879115172;752.3116348541133;773.5745340062942;10694.144468442506;10936.671899843017;11022.228444008842;11036.11711063113;11141.610043648434;692.5013989927244;725.3399406540024;746.8879668049836;759.6315786843377;767.5739964319856;5286.841394758163;5501.972490137604;5534.142207957773;5628.9586426510405;5668.433156684381;130671;131033.34483327523;131115.34442327727;132237.67762322447;133238;99312.5034374838;100598.4970075145;102325;106073.46963265134;106811.46594266979;55761.163582546294;76263.23736762672;89873.55063224773;92728;94500;10321.48392580353;10504.632337868137;10626.415547144981;10728.463576820972;10956.506957186786;37635.62364376321;38999.41500877546;42517;45533;51110;70418.64790676013;72586.27413726006;75109;75759.62120189363;75871.62064189644;12186.329751863732;12365.319907405179;13425;13554.051216414757;13690.178589284675;15240.237988100329;15671.921640391725;15965.44120955761;16096.597585060466;17079.573010674834;13827.654308641962;13919.164850109026;14049.22729249901;15705.764413534034;15706;13788.061883662327;13966.36973474313;14037.929810350883;14795.556133316019;15144;14692.265386730407;14762.188079655722;14965.027273227206;15001.099934003994;15106.320215590544;11407.600733974272;11430.428478576205;11434.542618295507;11710.648680539598;11957.342346171044;11441.256318339614;11561.364124973206;11766.411679415824;12085.456154472893;12401.689957751129 03:21:55 INFO - PROCESS | 3492 | __end_tp_report 03:21:55 INFO - PROCESS | 3492 | __start_cc_report 03:21:55 INFO - PROCESS | 3492 | _x_x_mozilla_cycle_collect,337 03:21:55 INFO - PROCESS | 3492 | __end_cc_report 03:21:55 INFO - PROCESS | 3492 | __startTimestamp1469874115692__endTimestamp 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | ------- Summary: start ------- 03:21:55 INFO - PROCESS | 3492 | Number of tests: 6 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | [#0] dojo.html Cycles:165 Average:5546.63 Median:5781.86 stddev:609.90 (10.5%) stddev-sans-first:586.04 03:21:55 INFO - PROCESS | 3492 | Values: 3312.4 3318.4 3319.3 3350.6 3368.0 5444.6 5448.7 5459.1 5463.2 5466.8 5558.5 5598.2 5606.7 5608.8 5620.4 5038.5 5056.9 5102.2 5168.5 5199.6 5024.3 5052.1 5091.5 5109.0 5176.4 5110.9 5112.7 5113.4 5120.3 5126.2 5122.5 5178.4 5190.8 5194.7 5238.6 4923.1 5094.0 5109.9 5137.9 5174.6 5366.7 5370.3 5378.2 5427.2 5454.3 5920.6 5955.6 5958.9 5960.8 5964.4 5998.6 6000.9 6005.8 6011.0 6018.4 5448.7 5546.1 5548.4 5610.0 5631.4 6057.2 6108.9 6126.3 6135.4 6143.4 5707.3 5860.7 5880.1 5902.9 5920.2 5891.4 5899.7 5939.6 5997.9 6006.9 5931.4 5960.5 5964.2 5967.4 5979.1 5718.8 5884.9 5973.5 5976.8 5983.3 4545.7 4561.5 4565.2 4592.5 4615.8 4090.8 4113.2 4123.4 4138.6 4151.6 5692.7 5693.7 5716.2 5753.2 5818.5 5814.7 5909.2 5953.0 6003.4 6007.2 5768.3 5781.9 5788.5 5791.7 5797.6 5039.6 5049.3 5055.0 5099.1 5136.0 6191.6 6196.2 6247.4 6265.1 6275.1 5980.7 5997.6 6000.1 6008.2 6018.0 6073.5 6113.7 6124.3 6146.0 6232.9 5823.5 5825.5 5830.7 5852.3 5857.3 5856.6 5940.0 5942.6 5944.5 5945.0 5740.1 5757.4 5768.3 5853.9 5869.8 5805.0 5825.8 5843.4 5848.3 5856.3 5524.9 5709.9 5721.7 5731.7 5761.2 5841.2 5844.9 5872.8 5890.6 5916.8 5758.2 5766.5 5800.9 5810.9 5812.4 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | [#1] ext.html Cycles:180 Average:70537.88 Median:23764.56 stddev:158303.44 (666.1%) stddev-sans-first:158660.41 03:21:55 INFO - PROCESS | 3492 | Values: 591.1 637.5 649.7 657.3 665.2 43589.0 44890.6 45266.3 45452.5 48620.5 46878.5 47719.5 47747.3 47795.8 47800.8 9108.7 9185.3 9203.6 9268.2 9276.0 8883.5 8923.6 8961.6 8972.1 9004.0 9038.3 9098.3 9101.9 9107.2 9107.7 8931.2 9000.4 9004.9 9033.4 9078.7 9051.0 9060.4 9119.9 9133.0 9147.1 44693.1 45125.8 45209.0 45349.8 45360.3 3776.3 3843.8 3872.6 3898.9 3956.5 33615.7 33858.7 33948.7 34180.5 34337.7 4325.8 4335.0 4337.3 4367.6 4438.6 353091.0 356370.0 356431.0 357181.0 357402.0 59880.7 60370.0 60430.4 60441.7 60599.1 38553.4 39167.2 39306.8 40918.0 41162.8 18659.0 18971.4 19123.9 19177.6 19271.1 14803.0 14994.9 15048.9 15119.2 15135.5 20706.8 20774.4 21062.7 21100.7 21171.5 7731.5 7803.0 7836.2 7921.7 7988.7 1083.2 1104.6 1133.3 1190.8 1199.5 32892.2 32957.3 33215.2 33321.3 33590.3 1126.4 1164.8 1246.8 1253.4 1294.5 17028.5 17067.0 17271.4 17339.8 17368.9 633751.0 643705.0 646098.0 971695.0 980073.0 62644.1 63782.4 64180.0 64232.7 64314.0 1313.8 1331.9 1343.6 1348.2 1406.2 32560.5 32988.7 33334.0 33673.0 33837.0 53075.5 53459.0 53539.2 53769.7 54197.7 525082.0 536284.0 536767.0 537094.0 541538.0 30136.7 30352.7 30521.8 30530.0 30531.2 50351.0 50891.0 50977.0 51600.7 52857.0 41639.6 41751.8 42982.4 43041.8 43098.0 40572.4 42708.0 42796.0 43203.4 44415.1 42775.4 43017.6 43648.8 44336.1 44458.8 37630.8 37785.4 38002.4 38275.6 38345.0 29398.0 29562.7 29846.0 30086.7 30124.7 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | [#2] jquery.html Cycles:180 Average:30186.88 Median:435.93 stddev:90287.24 (20711.5%) stddev-sans-first:90512.87 03:21:55 INFO - PROCESS | 3492 | Values: 426.2 429.8 432.8 435.3 436.5 18466.9 19596.9 20099.3 20793.6 20839.4 19002.4 19149.6 19432.8 20007.0 20026.9 5635.5 5799.4 5804.7 5811.6 5832.6 5570.4 5700.5 5744.1 5768.7 5782.7 5693.9 5711.9 5719.5 5719.9 5729.4 5513.5 5713.3 5722.9 5766.8 5776.9 5086.8 5154.4 5177.7 5237.1 5240.3 23358.6 24180.2 24284.0 24531.8 24630.8 2472.2 2507.4 2555.6 2782.4 2853.6 14690.0 14826.4 14959.3 15188.2 15241.8 2078.7 2118.4 2164.6 2183.6 2225.1 54680.5 70960.0 71907.6 76671.6 77557.2 10774.7 11055.5 11458.9 11477.4 12312.5 15829.4 15885.0 15919.0 15974.1 16015.6 8386.5 8454.7 8498.9 8577.9 8761.3 8294.0 8343.7 8421.5 8549.8 8570.0 6941.7 7025.0 7056.1 7123.5 7168.1 1972.9 1983.6 2014.2 2020.2 2031.7 452.1 475.1 480.3 496.6 985.8 11916.5 12086.0 12131.5 12165.1 12257.7 486.7 490.8 492.0 507.4 509.5 6366.8 6410.8 6527.7 6652.3 6674.7 537606.0 544814.0 548434.0 552096.0 562462.0 78027.6 100210.5 100255.5 100482.5 100839.0 459.4 470.7 486.0 490.5 493.8 10944.1 11539.8 11578.0 11630.3 11653.9 39264.0 41436.4 41956.0 42769.8 43443.3 59490.0 59703.7 59808.0 60277.1 60427.1 8268.8 8386.7 8679.9 8706.3 8761.4 8374.6 8936.4 10073.0 11792.8 12929.2 10740.8 10835.6 10930.6 11003.2 11084.0 11041.5 11078.6 11108.3 11315.9 11492.9 11565.1 11756.7 11809.7 11945.3 11991.5 7412.8 8516.7 8582.8 8595.5 8797.2 10307.4 11212.2 11602.9 11624.6 11766.8 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | [#3] mootools.html Cycles:180 Average:6122.12 Median:4393.55 stddev:3530.87 (80.4%) stddev-sans-first:3523.27 03:21:55 INFO - PROCESS | 3492 | Values: 1443.8 1558.8 1763.2 1828.5 1881.4 8351.7 8403.2 9337.2 9695.7 9720.1 8761.4 9009.6 9203.8 9219.9 9231.5 2420.2 2482.9 2496.2 2497.4 2497.5 2411.6 2471.2 2482.4 2490.9 2493.1 2441.9 2457.1 2479.5 2484.4 2491.8 2425.1 2433.2 2457.8 2458.3 2475.7 2359.5 2364.9 2365.8 2368.0 2435.4 8948.5 8955.6 8985.8 9033.1 9273.3 5411.9 5492.3 5518.0 5526.9 5574.5 3556.7 3562.4 3621.3 3762.6 3801.4 1215.5 1225.8 1258.7 1261.2 1302.8 12849.3 13123.5 13129.7 13181.6 13196.7 4912.9 4947.8 4971.8 5080.2 5100.7 11356.6 11386.1 11398.7 11449.7 11451.4 5370.0 5376.5 5397.9 5398.9 5419.8 4475.4 4882.3 4884.1 4998.5 5037.4 4292.9 4344.0 4386.2 4400.9 4436.6 1337.9 1380.8 1381.6 1381.9 1391.5 944.9 1018.7 1024.8 1028.1 1030.6 5949.5 6032.0 6042.2 6095.5 6210.9 881.5 1034.9 1044.7 1049.5 1078.6 4063.3 4147.4 4228.2 4232.5 4249.6 11633.8 11955.8 11970.9 12000.7 12048.7 11412.3 11789.0 11801.3 11851.4 11893.0 8409.7 8441.3 8665.8 8676.9 8691.3 6024.8 6097.7 6122.7 6144.7 6146.8 10611.1 10763.2 10803.8 10901.8 10921.2 11060.8 11127.6 11129.9 11275.5 11304.4 7243.3 7489.3 7710.5 7939.2 8096.6 9061.8 9120.5 9150.8 9169.9 9171.3 7789.9 7972.0 8040.5 8046.1 8057.5 7907.9 7987.5 8054.0 8118.6 8264.1 7240.6 7336.4 7342.7 7348.5 7464.4 5211.2 5261.2 5270.8 5297.3 5340.8 5052.9 5070.9 5245.9 5270.1 5319.1 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | [#4] prototype.html Cycles:180 Average:4903.53 Median:5494.11 stddev:1442.59 (26.3%) stddev-sans-first:1405.36 03:21:55 INFO - PROCESS | 3492 | Values: 338.6 339.1 340.7 351.3 354.7 5503.4 5595.7 5620.5 5721.5 5752.2 5596.5 5603.5 5607.8 5628.9 5644.3 4383.6 4384.4 4416.4 4428.3 4433.1 4180.4 4403.4 4442.3 4445.1 4445.2 4332.0 4353.7 4376.4 4390.3 4395.0 4410.6 4419.5 4430.4 4481.4 4483.7 3772.3 3840.3 3912.5 3928.4 3942.1 5445.9 5458.7 5459.9 5464.3 5487.9 4952.4 4986.1 4988.4 5040.3 5084.9 5787.2 5841.9 5872.6 5929.5 5930.1 4214.8 4230.9 4233.5 4243.8 4252.2 6173.2 6181.3 6210.2 6232.9 6240.2 4159.4 4304.7 4307.4 4318.4 4350.6 4371.4 4389.1 4389.2 4389.5 4402.0 5016.4 5030.2 5049.8 5053.2 5058.3 5813.3 5886.3 5915.7 5963.6 6035.6 1498.4 1502.4 1518.4 1521.8 1524.4 928.5 949.7 951.9 967.7 985.1 5214.5 5227.3 5233.8 5257.3 5279.8 5410.8 5464.4 5500.4 5502.7 5503.9 5047.7 5206.3 5213.9 5219.5 5251.1 2890.3 2921.6 2930.8 2931.9 2949.5 5632.5 5667.7 5686.4 5689.8 5746.5 5216.0 5460.6 5623.8 5645.7 5650.4 5655.0 5708.0 5709.5 5718.2 5753.3 5460.6 5478.5 5602.7 5752.2 6236.3 6081.3 6105.2 6123.1 6161.4 6168.7 6254.3 6343.2 6464.9 6543.9 6569.6 4381.8 4456.4 4466.4 4472.8 4473.4 6174.7 6198.6 6205.9 6246.2 6249.7 5709.0 6000.9 6031.7 6040.3 6069.0 6009.4 6027.2 6027.3 6029.7 6033.4 5719.2 5922.3 5922.5 5922.6 5925.9 6033.7 6035.2 6035.8 6049.0 6051.3 5918.2 5934.2 5941.3 5958.6 5969.7 03:21:55 INFO - PROCESS | 3492 | 03:21:55 INFO - PROCESS | 3492 | [#5] yui.html Cycles:180 Average:21429.06 Median:3639.67 stddev:31230.88 (858.1%) stddev-sans-first:31280.10 03:21:55 INFO - PROCESS | 3492 | Values: 805.4 814.4 834.0 848.8 891.0 15570.2 16278.9 16450.8 16549.8 16579.9 13301.2 13371.1 13378.6 13463.5 13477.7 709.2 843.7 848.3 862.4 871.0 857.3 858.3 862.9 868.8 870.4 913.2 915.1 916.2 916.8 917.0 893.0 899.8 900.3 901.3 901.6 670.0 670.7 674.7 674.9 675.2 15361.3 15380.2 15418.9 15452.8 15465.5 15877.4 16278.3 16556.2 16635.3 16717.8 12892.0 12899.4 13052.9 13105.7 13240.5 4036.9 4057.7 4070.4 4108.3 4154.3 74511.0 74862.6 75492.0 75817.0 76103.0 12479.9 12565.8 12613.8 12657.9 12740.3 22426.2 22522.9 22543.1 22558.9 22675.8 9248.7 9336.4 9345.0 9363.1 9421.1 4973.2 5020.4 5059.1 5080.1 5211.5 3528.1 3638.2 3641.2 3647.0 3660.7 625.3 627.8 643.1 662.7 666.5 670.1 745.6 749.7 752.3 773.6 10694.1 10936.7 11022.2 11036.1 11141.6 692.5 725.3 746.9 759.6 767.6 5286.8 5502.0 5534.1 5629.0 5668.4 130671.0 131033.3 131115.3 132237.7 133238.0 99312.5 100598.5 102325.0 106073.5 106811.5 55761.2 76263.2 89873.6 92728.0 94500.0 10321.5 10504.6 10626.4 10728.5 10956.5 37635.6 38999.4 42517.0 45533.0 51110.0 70418.6 72586.3 75109.0 75759.6 75871.6 12186.3 12365.3 13425.0 13554.1 13690.2 15240.2 15671.9 15965.4 16096.6 17079.6 13827.7 13919.2 14049.2 15705.8 15706.0 13788.1 13966.4 14037.9 14795.6 15144.0 14692.3 14762.2 14965.0 15001.1 15106.3 11407.6 11430.4 11434.5 11710.6 11957.3 11441.3 11561.4 11766.4 12085.5 12401.7 03:21:55 INFO - PROCESS | 3492 | -------- Summary: end -------- 03:21:55 INFO - PROCESS | 3492 | 03:21:56 INFO - TEST-INFO | 3492: exit 0 03:21:56 INFO - TEST-OK | dromaeo_css | took 1112177ms 03:21:56 INFO - TEST-START | kraken 03:21:56 INFO - operating with platform_type : linux_ 03:21:56 INFO - Initialising browser for kraken test... 03:21:56 INFO - TEST-INFO | started process 3744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY0DbvM/profile http://localhost:49000/getInfo.html) 03:22:00 INFO - PROCESS | 3744 | __metrics Screen width/height:1600/1200 03:22:00 INFO - PROCESS | 3744 | colorDepth:24 03:22:00 INFO - PROCESS | 3744 | Browser inner width/height: 1024/697 03:22:00 INFO - PROCESS | 3744 | __metrics 03:22:01 ERROR - PROCESS | 3744 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:22:02 INFO - TEST-INFO | 3744: exit 0 03:22:02 INFO - Browser initialized. 03:22:02 INFO - Running cycle 1/1 for kraken test... 03:22:02 INFO - TEST-INFO | started process 3876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY0DbvM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:14 INFO - PROCESS | 3876 | RSS: Main: 155840512 03:22:14 INFO - PROCESS | 3876 | 03:22:16 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-beat-detection) 03:22:17 INFO - PROCESS | 3876 | RSS: Main: 161390592 03:22:17 INFO - PROCESS | 3876 | 03:22:20 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-dft) 03:22:20 INFO - PROCESS | 3876 | RSS: Main: 160514048 03:22:20 INFO - PROCESS | 3876 | 03:22:23 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-fft) 03:22:24 INFO - PROCESS | 3876 | RSS: Main: 161394688 03:22:24 INFO - PROCESS | 3876 | 03:22:26 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49000/tests/kraken/driver.html?testName=audio-oscillator) 03:22:26 INFO - PROCESS | 3876 | RSS: Main: 160927744 03:22:26 INFO - PROCESS | 3876 | 03:22:28 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49000/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:22:29 INFO - PROCESS | 3876 | RSS: Main: 160583680 03:22:29 INFO - PROCESS | 3876 | 03:22:32 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49000/tests/kraken/driver.html?testName=imaging-darkroom) 03:22:33 INFO - PROCESS | 3876 | RSS: Main: 160260096 03:22:33 INFO - PROCESS | 3876 | 03:22:36 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49000/tests/kraken/driver.html?testName=imaging-desaturate) 03:22:37 INFO - PROCESS | 3876 | RSS: Main: 161361920 03:22:37 INFO - PROCESS | 3876 | 03:22:40 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49000/tests/kraken/driver.html?testName=json-parse-financial) 03:22:40 INFO - PROCESS | 3876 | RSS: Main: 160768000 03:22:40 INFO - PROCESS | 3876 | 03:22:42 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49000/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:22:42 INFO - PROCESS | 3876 | RSS: Main: 160690176 03:22:42 INFO - PROCESS | 3876 | 03:22:44 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:22:45 INFO - PROCESS | 3876 | RSS: Main: 160882688 03:22:45 INFO - PROCESS | 3876 | 03:22:47 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:22:48 INFO - PROCESS | 3876 | RSS: Main: 161689600 03:22:48 INFO - PROCESS | 3876 | 03:22:50 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:22:51 INFO - PROCESS | 3876 | RSS: Main: 161533952 03:22:51 INFO - PROCESS | 3876 | 03:22:53 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:54 INFO - PROCESS | 3876 | RSS: Main: 161366016 03:22:54 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | Cycle 1(1): loaded http://localhost:49000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49000/tests/kraken/driver.html?testName=ai-astar) 03:22:56 INFO - PROCESS | 3876 | RSS: Main: 162250752 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | __start_tp_report 03:22:56 INFO - PROCESS | 3876 | _x_x_mozilla_page_load 03:22:56 INFO - PROCESS | 3876 | _x_x_mozilla_page_load_details 03:22:56 INFO - PROCESS | 3876 | |i|pagename|runs| 03:22:56 INFO - PROCESS | 3876 | |0;ai-astar;115;106;111;110;114;112;110;110;110;110 03:22:56 INFO - PROCESS | 3876 | |1;audio-beat-detection;154;123;154;192;125;157;148;126;176;124 03:22:56 INFO - PROCESS | 3876 | |2;audio-dft;162;163;161;161;160;164;164;161;163;160 03:22:56 INFO - PROCESS | 3876 | |3;audio-fft;74;75;76;175;77;78;76;75;160;78 03:22:56 INFO - PROCESS | 3876 | |4;audio-oscillator;84;84;148;86;85;84;139;84;85;149 03:22:56 INFO - PROCESS | 3876 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;117;117;117 03:22:56 INFO - PROCESS | 3876 | |6;imaging-darkroom;148;147;148;146;147;148;148;146;149;148 03:22:56 INFO - PROCESS | 3876 | |7;imaging-desaturate;96;96;97;95;95;96;95;97;96;95 03:22:56 INFO - PROCESS | 3876 | |8;json-parse-financial;51;50;52;52;53;51;52;51;51;51 03:22:56 INFO - PROCESS | 3876 | |9;json-stringify-tinderbox;60;62;61;61;62;61;61;60;61;62 03:22:56 INFO - PROCESS | 3876 | |10;stanford-crypto-aes;78;76;80;84;79;78;78;79;100;85 03:22:56 INFO - PROCESS | 3876 | |11;stanford-crypto-ccm;133;117;124;132;118;121;124;129;128;122 03:22:56 INFO - PROCESS | 3876 | |12;stanford-crypto-pbkdf2;155;155;154;154;161;159;154;165;157;155 03:22:56 INFO - PROCESS | 3876 | |13;stanford-crypto-sha256-iterative;63;66;61;61;60;61;64;64;61;61 03:22:56 INFO - PROCESS | 3876 | __end_tp_report 03:22:56 INFO - PROCESS | 3876 | __start_cc_report 03:22:56 INFO - PROCESS | 3876 | _x_x_mozilla_cycle_collect,856 03:22:56 INFO - PROCESS | 3876 | __end_cc_report 03:22:56 INFO - PROCESS | 3876 | __startTimestamp1469874176469__endTimestamp 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | ------- Summary: start ------- 03:22:56 INFO - PROCESS | 3876 | Number of tests: 14 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.50 stddev:2.49 (2.2%) stddev-sans-first:2.12 03:22:56 INFO - PROCESS | 3876 | Values: 115.0 106.0 111.0 110.0 114.0 112.0 110.0 110.0 110.0 110.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:154.00 stddev:23.77 (15.4%) stddev-sans-first:25.11 03:22:56 INFO - PROCESS | 3876 | Values: 154.0 123.0 154.0 192.0 125.0 157.0 148.0 126.0 176.0 124.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.52 (0.9%) stddev-sans-first:1.62 03:22:56 INFO - PROCESS | 3876 | Values: 162.0 163.0 161.0 161.0 160.0 164.0 164.0 161.0 163.0 160.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:38.71 (50.9%) stddev-sans-first:40.35 03:22:56 INFO - PROCESS | 3876 | Values: 74.0 75.0 76.0 175.0 77.0 78.0 76.0 75.0 160.0 78.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.00 stddev:29.47 (35.1%) stddev-sans-first:30.46 03:22:56 INFO - PROCESS | 3876 | Values: 84.0 84.0 148.0 86.0 85.0 84.0 139.0 84.0 85.0 149.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:22:56 INFO - PROCESS | 3876 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:22:56 INFO - PROCESS | 3876 | Values: 148.0 147.0 148.0 146.0 147.0 148.0 148.0 146.0 149.0 148.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:22:56 INFO - PROCESS | 3876 | Values: 96.0 96.0 97.0 95.0 95.0 96.0 95.0 97.0 96.0 95.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:0.84 (1.6%) stddev-sans-first:0.88 03:22:56 INFO - PROCESS | 3876 | Values: 51.0 50.0 52.0 52.0 53.0 51.0 52.0 51.0 51.0 51.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 03:22:56 INFO - PROCESS | 3876 | Values: 60.0 62.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 62.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:79.00 stddev:7.01 (8.9%) stddev-sans-first:7.30 03:22:56 INFO - PROCESS | 3876 | Values: 78.0 76.0 80.0 84.0 79.0 78.0 78.0 79.0 100.0 85.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:126.00 stddev:5.55 (4.4%) stddev-sans-first:5.04 03:22:56 INFO - PROCESS | 3876 | Values: 133.0 117.0 124.0 132.0 118.0 121.0 124.0 129.0 128.0 122.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:156.00 stddev:3.70 (2.4%) stddev-sans-first:3.86 03:22:56 INFO - PROCESS | 3876 | Values: 155.0 155.0 154.0 154.0 161.0 159.0 154.0 165.0 157.0 155.0 03:22:56 INFO - PROCESS | 3876 | 03:22:56 INFO - PROCESS | 3876 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.93 (3.1%) stddev-sans-first:2.03 03:22:56 INFO - PROCESS | 3876 | Values: 63.0 66.0 61.0 61.0 60.0 61.0 64.0 64.0 61.0 61.0 03:22:56 INFO - PROCESS | 3876 | -------- Summary: end -------- 03:22:56 INFO - PROCESS | 3876 | 03:22:57 INFO - TEST-INFO | 3876: exit 0 03:22:57 INFO - TEST-OK | kraken | took 61040ms 03:22:57 INFO - SUITE-END | took 1173s 03:22:57 INFO - Completed test suite (00:19:33) 03:22:57 INFO - javascript benchmark 03:22:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7479.248680005036, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.354090952264, 3318.4026875162467, 3319.30294638126, 3350.63143054264, 3368.00643810076, 5444.646098003632, 5448.727563621823, 5459.12653975364, 5463.235147079412, 5466.835994920154, 5558.527525160366, 5598.188262701906, 5606.691631960241, 5608.831735047945, 5620.437956204378, 5038.496150384969, 5056.949430505703, 5102.158143906251, 5168.534831865131, 5199.6360254782185, 5024.346834911456, 5052.065367906949, 5091.516305950947, 5108.974455127719, 5176.404713457944, 5110.872228194287, 5112.718800465973, 5113.411957624865, 5120.334356533645, 5126.2054381570915, 5122.513361230677, 5178.404483484391, 5190.844274671766, 5194.662346947436, 5238.633295669305, 4923.113839508887, 5094.032133894548, 5109.923351149736, 5137.922931156036, 5174.611904107207, 5366.677999320014, 5370.275012873251, 5378.1663842104535, 5427.213054107172, 5454.263674403984, 5920.615160014629, 5955.583109182359, 5958.851028724273, 5960.761569537213, 5964.403559644044, 5998.610090344114, 6000.879982400327, 6005.849853753647, 6011.038233882601, 6018.368071352533, 5448.727563621803, 5546.084895992157, 5548.44515548446, 5610.018246806833, 5631.352394474647, 6057.212562366953, 6108.938910610837, 6126.295476020315, 6135.355787642323, 6143.447089761943, 5707.315122185281, 5860.706964651836, 5880.117982302689, 5902.911456328158, 5920.200772895604, 5891.351951285355, 5899.734511946973, 5939.613925094855, 5997.850053748692, 6006.879862402728, 5931.40685931412, 5960.4635582797755, 5964.194833697482, 5967.433093856077, 5979.103134529855, 5718.828435146952, 5884.882302353929, 5973.522118230531, 5976.760929562855, 5983.282006159288, 4545.659075569345, 4561.521040290788, 4565.155446242456, 4592.494825569184, 4615.792289346988, 4090.836366545305, 4113.218488487178, 4123.36087906375, 4138.627523522837, 4151.584841515824, 5692.715364231854, 5693.686847223443, 5716.228309178207, 5753.194552762617, 5818.4763371296785, 5814.709264536841, 5909.172715819789, 5952.970235148883, 6003.399660034049, 6007.219061521974, 5768.278965129359, 5781.8554536136935, 5788.5369170466265, 5791.739371728282, 5797.565182611321, 5039.5968322534845, 5049.343585333883, 5055.039542486916, 5099.107656160231, 5136.049830781318, 6191.597546159575, 6196.1635179251125, 6247.437730604267, 6265.091561723524, 6275.090111933744, 5980.730867110903, 5997.610155339889, 6000.129981152796, 6008.24896887889, 6018.0, 6073.514118870568, 6113.749968914014, 6124.295705993868, 6145.985912324416, 6232.937670623417, 5823.505002074871, 5825.50483208932, 5830.650160990354, 5852.268466441695, 5857.26784151981, 5856.648601083949, 5939.970300148471, 5942.64344139353, 5944.524438045032, 5944.970275148769, 5740.1102829061565, 5757.424257574209, 5768.336641286138, 5853.882922341614, 5869.8239052828485, 5805.0, 5825.825225243249, 5843.357230704534, 5848.2689663792025, 5856.267966504187, 5524.861878453071, 5709.914351284817, 5721.685307308138, 5731.656100633975, 5761.193432919311, 5841.18223448709, 5844.94155058461, 5872.823815285548, 5890.646561206341, 5916.763329466773, 5758.193852860687, 5766.452187042224, 5800.854978625568, 5810.94189058104, 5812.389699081536], "value": 5507.244539073514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.0513625630863, 637.509117979156, 649.68814968815, 657.2835609185988, 665.2416245480154, 43589.0, 44890.55109448905, 45266.321005184946, 45452.545474545244, 48620.51379486204, 46878.53121468784, 47719.52280477194, 47747.28379074317, 47795.761021194936, 47800.76099619506, 9108.726738197847, 9185.265178785714, 9203.585838637244, 9268.21220196284, 9276.0, 8883.46699198047, 8923.553822308892, 8961.641534338618, 8972.147645973622, 9004.0, 9038.276937844958, 9098.31762617803, 9101.908980910172, 9107.180353768159, 9107.68123115691, 8931.240844528224, 9000.414973026733, 9004.909950900472, 9033.412828166181, 9078.727638170865, 9051.0, 9060.365774395796, 9119.863202051974, 9133.0, 9147.085291470867, 44693.10613787706, 45125.77437112826, 45209.0, 45349.77325113386, 45360.3195952061, 3776.3202623527754, 3843.7501562398356, 3872.612738726105, 3898.9018442234465, 3956.5449973253158, 33615.66384336174, 33858.661413385795, 33948.66051339504, 34180.48729269063, 34337.65662343369, 4325.762083085429, 4335.0, 4337.284348082594, 4367.585079417482, 4438.578335058164, 353091.0, 356370.0, 356431.0, 357181.0, 357401.9999999974, 59880.70059649674, 60370.0, 60430.39569604336, 60441.697791511644, 60599.09101363395, 38553.421698674545, 39167.21665566673, 39306.803465982484, 40918.0, 41162.79418602888, 18659.0, 18971.43085707431, 19123.90438047801, 19177.616447671247, 19271.13279902408, 14803.0, 14994.925025375022, 15048.924755376152, 15119.244037798066, 15135.545933622008, 20706.792932070788, 20774.376768696962, 21062.68405973881, 21100.683489747666, 21171.47071323229, 7731.497452665559, 7802.98561187042, 7836.177201393885, 7921.722739704082, 7988.720394786271, 1083.2146693647044, 1104.5802595014004, 1133.2633788037676, 1190.7975644140517, 1199.5201919232377, 32892.1776955578, 32957.3408531828, 33215.16962075919, 33321.333573328884, 33590.32819343599, 1126.3748619516248, 1164.8310994905692, 1246.8192112143688, 1253.3607859991287, 1294.4822071171607, 17028.48914532566, 17067.0, 17271.3955011574, 17339.826601734072, 17368.91315543414, 633751.0, 643705.0, 646098.0, 971695.0, 980073.0, 62644.06033909495, 63782.36217637857, 64179.99999999907, 64232.67883660645, 64314.0, 1313.8160657507956, 1331.8867896228735, 1343.6237853401258, 1348.157401623985, 1406.1633328169723, 32560.51159232661, 32988.67011329952, 33334.0, 33673.0, 33837.0, 53075.46924530705, 53459.0, 53539.19691204557, 53769.73115134399, 54197.72901135469, 525082.0, 536284.0, 536767.0, 537094.0, 541538.0, 30136.698633013388, 30352.696473034986, 30521.779128834598, 30530.0, 30531.236719081313, 50351.0, 50891.0, 50977.0, 51600.74199628978, 52857.0, 41639.649599848795, 41751.791241043604, 42982.35526467168, 43041.78479107584, 43098.0, 40572.3914141294, 42708.0, 42796.0, 43203.35194972141, 44415.11169776522, 42775.3583696251, 43017.569824302605, 43648.78175609102, 44336.11327773491, 44458.777706111265, 37630.811845940596, 37785.433218502294, 38002.429963550014, 38275.61724382832, 38345.0, 29398.0, 29562.704372956854, 29846.0, 30086.699133009264, 30124.698753012188], "value": 21273.82107574991, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.1689705075104, 429.7915510977177, 432.81389002728815, 435.3491530162408, 436.50892745661133, 18466.90766546167, 19596.90201548992, 20099.29652462164, 20793.584128317423, 20839.374818755463, 19002.429927102174, 19149.617007659872, 19432.805671943275, 20007.0, 20026.89986550065, 5635.464630860061, 5799.391063938289, 5804.651720896739, 5811.564132690065, 5832.59171857968, 5570.415106413829, 5700.458456446651, 5744.080947048473, 5768.653880767168, 5782.653040817564, 5693.857653558653, 5711.857203569903, 5719.542436605062, 5719.942800572004, 5729.427057294258, 5513.531349835289, 5713.342965558952, 5722.914156287659, 5766.826995190151, 5776.913346299809, 5086.847394578169, 5154.355705536808, 5177.689338639656, 5237.13587258102, 5240.318758561362, 23358.64962025571, 24180.153694620778, 24284.0, 24531.754682453124, 24630.753692463026, 2472.171822439485, 2507.4232926427026, 2555.552778263815, 2782.401783616532, 2853.6004959305715, 14690.0, 14826.406943722239, 14959.326830292553, 15188.240587970557, 15241.847581524265, 2078.6570215914358, 2118.353902059871, 2164.6428339323993, 2183.563287342538, 2225.054351900436, 54680.45319546793, 70960.0, 71907.64046179736, 76671.61664191699, 77557.22442775556, 10774.676759697222, 11055.502502387411, 11458.885411145948, 11477.426128693533, 12312.507499699912, 15829.366825326859, 15885.0, 15919.044857308598, 15974.121423321596, 16015.599610009844, 8386.496810191407, 8454.704085356983, 8498.872516912252, 8577.871331930026, 8761.34289928258, 8294.0, 8343.66625334992, 8421.536815475207, 8549.786255343666, 8569.95715021421, 6941.722331106699, 7025.0, 7056.082709247765, 7123.465740069516, 7168.068151140318, 1972.859447499479, 1983.5537004173946, 2014.204389266261, 2020.1515363547346, 2031.7358743363563, 452.12513785824535, 475.1352538380184, 480.3011618095662, 496.62256684919, 985.7584891701579, 11916.46375913086, 12086.0, 12131.454084566216, 12165.14843960932, 12257.69355766113, 486.69095124596134, 490.825756856318, 491.97540122993706, 507.3708601334319, 509.4726957598941, 6366.77716279928, 6410.775622853178, 6527.706253218616, 6652.301508341651, 6674.699638516278, 537606.0, 544814.0, 548434.0, 552096.0, 562462.0, 78027.60986195147, 100210.49894750626, 100255.49872250592, 100482.49758751159, 100839.0, 459.4165409929438, 470.691696938499, 485.98299059532746, 490.49724032866595, 493.75805855131443, 10944.124470042536, 11539.769204616028, 11578.0, 11630.302181869114, 11653.941730291293, 39264.0183995391, 41436.37845432261, 41956.0, 42769.78615106905, 43443.34834977415, 59490.0, 59703.70148149405, 59808.0, 60277.09584356326, 60427.09359359701, 8268.793280168044, 8386.748397548083, 8679.86980195285, 8706.259967902546, 8761.386702930733, 8374.623141958748, 8936.41913275635, 10072.992700729868, 11792.76414471723, 12929.224246544862, 10740.785184296426, 10835.566577336818, 10930.617428389969, 11003.22977391575, 11084.0, 11041.503132359223, 11078.5568577256, 11108.333499990027, 11315.943420282845, 11492.885071149181, 11565.108722819296, 11756.70608234801, 11809.704757381134, 11945.343006134746, 11991.460384282902, 7412.814679633052, 8516.70191543293, 8582.841316422453, 8595.484270943763, 8797.164269394398, 10307.381557106597, 11212.159088068265, 11602.88397116018, 11624.593139240085, 11766.823497647714], "value": 8636.648250627195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.7617793064144, 1558.7739777732227, 1763.1977450260133, 1828.4788835181976, 1881.397952655151, 8351.665933362674, 8403.159684031594, 9337.159655630992, 9695.709128726141, 9720.076592723688, 8761.43050701704, 9009.594568244429, 9203.849518810148, 9219.907800921988, 9231.492267925261, 2420.2013335599254, 2482.888270027844, 2496.1887386599337, 2497.438076432806, 2497.500499900018, 2411.6141417373224, 2471.1845091119885, 2482.4290413204885, 2490.9252722418355, 2493.1024831060804, 2441.8779061046966, 2457.1154384421593, 2479.454520005596, 2484.3789052736815, 2491.750824917512, 2425.0542288507495, 2433.2092070077206, 2457.766512181358, 2458.299384675359, 2475.665785119013, 2359.528094381131, 2364.8817559121976, 2365.8343915925893, 2368.0, 2435.415500279938, 8948.463092214488, 8955.596998135099, 8985.820283594292, 9033.141851524095, 9273.258139348836, 5411.891762164734, 5492.313460817398, 5518.034343989826, 5526.861828454321, 5574.498295153456, 3556.6621170988715, 3562.3765840977726, 3621.257642183346, 3762.6049264827075, 3801.391777315644, 1215.4530461292454, 1225.8099994500867, 1258.7356655102349, 1261.186534685123, 1302.7720148973892, 12849.293288869108, 13123.540676076387, 13129.737405251937, 13181.60455186346, 13196.736065278737, 4912.901741965141, 4947.787791990985, 4971.801127954841, 5080.212567052113, 5100.668456550312, 11356.602518911799, 11386.146039047104, 11398.715032124097, 11449.71375715597, 11451.427428628534, 5370.03339398912, 5376.489233522809, 5397.919031214535, 5398.8920221595345, 5419.810306639249, 4475.351074094238, 4882.340883980617, 4884.096442158212, 4998.475160108209, 5037.370328708911, 4292.871213863589, 4344.044310251739, 4386.188555117314, 4400.911981760347, 4436.556344365602, 1337.8729020743015, 1380.8342998840203, 1381.5648070857649, 1381.9239941803298, 1391.5199256256576, 944.9244060475146, 1018.6638409324905, 1024.8155332040155, 1028.100412139378, 1030.567161792049, 5949.494292985059, 6032.0, 6042.214512113397, 6095.451409373089, 6210.937890621036, 881.4667126388571, 1034.906858382734, 1044.7492601775518, 1049.454283772434, 1078.6116997880756, 4063.2889244382113, 4147.419361289422, 4228.217779710763, 4232.534421213664, 4249.575042495726, 11633.76732465346, 11955.760884782256, 11970.940145299392, 12000.699982500508, 12048.698782530508, 11412.258203216765, 11788.997935175435, 11801.291922484506, 11851.407429628483, 11893.04855611549, 8409.705660301861, 8441.324694024463, 8665.783355416164, 8676.8698469523, 8691.348148888732, 6024.759009639565, 6097.695115244309, 6122.663253520921, 6144.692765361803, 6146.815595532141, 10611.09805666527, 10763.192760542834, 10803.837942430713, 10901.83647245276, 10921.180911431515, 11060.834087488854, 11127.554897803997, 11129.944350278196, 11275.548978040786, 11304.378259195822, 7243.311885370881, 7489.28851759082, 7710.498817577064, 7939.166387529226, 8096.595170241582, 9061.818763624822, 9120.49837258957, 9150.816983660423, 9169.862452063091, 9171.266298696222, 7789.922100779147, 7972.0, 8040.517568945882, 8046.0747014091785, 8057.476264042818, 7907.920920790949, 7987.520748755093, 8054.0, 8118.634661440367, 8264.132266111972, 7240.637968101679, 7336.413086953137, 7342.669579869025, 7348.485606007528, 7464.402847772274, 5211.1922651989, 5261.210818377274, 5270.789168433374, 5297.258383826191, 5340.78636854537, 5052.9494705052475, 5070.923936141035, 5245.9475405246985, 5270.130428479258, 5319.122344813062], "value": 4899.3646046446875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.6342749830183, 339.14513735871003, 340.67805923402386, 351.28162906855476, 354.68610279902293, 5503.367112782032, 5595.7202139893, 5620.522255608268, 5721.542276617871, 5752.223449834271, 5596.468335508121, 5603.467670571289, 5607.803726869561, 5628.859278518029, 5644.322681278242, 4383.583559561853, 4384.364267181257, 4416.381706561084, 4428.31361139024, 4433.13553856998, 4180.393842892794, 4403.4495688039, 4442.267025940716, 4445.133199026175, 4445.22208613493, 4332.025294308787, 4353.71700839446, 4376.387305777193, 4390.341448782692, 4394.956050439503, 4410.647148228134, 4419.469663640368, 4430.405054180493, 4481.3726078349055, 4483.730976141409, 3772.3038212299625, 3840.2511510255513, 3912.4913761211146, 3928.3910993796007, 3942.0933185367526, 5445.863853403657, 5458.6724796512335, 5459.94243223792, 5464.316960379952, 5487.859734703469, 4952.405711314629, 4986.127427700174, 4988.353843231725, 5040.294358789773, 5084.872878178038, 5787.189793428924, 5841.912371314391, 5872.5889187756875, 5929.495992840613, 5930.080837470199, 4214.7681877496725, 4230.894227644303, 4233.491980962273, 4243.787810609457, 4252.2345977724, 6173.228346456693, 6181.342022930138, 6210.192674952227, 6232.937670623326, 6240.188775459206, 4159.396887451303, 4304.677149213759, 4307.375430562551, 4318.417013703172, 4350.608445239944, 4371.366151908019, 4389.122175564899, 4389.166058448948, 4389.4513185851765, 4401.977990110029, 5016.372953380827, 5030.195168772979, 5049.798008079709, 5053.191489361684, 5058.291839142523, 5813.273340832396, 5886.280293367323, 5915.733791979371, 5963.612365196248, 6035.637861728311, 1498.4305963733711, 1502.4440956846038, 1518.4078209498305, 1521.8402067782945, 1524.3902439024257, 928.4614923344444, 949.6676163342913, 951.9381240219363, 967.7435479597913, 985.0986347491964, 5214.530692237717, 5227.26818245446, 5233.816816411408, 5257.26510251616, 5279.838435544174, 5410.756515956791, 5464.398916119224, 5500.367457742331, 5502.669839809624, 5503.889922201533, 5047.671901326402, 5206.271122042917, 5213.854985286706, 5219.530242278137, 5251.0571088697425, 2890.3496713239774, 2921.605583246277, 2930.809497382706, 2931.8973835916067, 2949.483840327934, 5632.549396048306, 5667.716614169275, 5686.431356864363, 5689.829305120853, 5746.511546518509, 5215.973920130375, 5460.563154947595, 5623.762772190112, 5645.745941432645, 5650.350209725934, 5655.0, 5708.0, 5709.514691251207, 5718.199452076713, 5753.338366087954, 5460.563154947674, 5478.534324582455, 5602.719864006865, 5752.245565102684, 6236.314005459487, 6081.300650425258, 6105.236845394325, 6123.14276001369, 6161.353057928853, 6168.655910753885, 6254.2807577129215, 6343.238811342669, 6464.935350646621, 6543.901841472287, 6569.638669873012, 4381.846635367747, 4456.442944631921, 4466.419365482467, 4472.776361181993, 4473.4408198975125, 6174.691265436621, 6198.566100372931, 6205.875882482234, 6246.156768836331, 6249.687615582264, 5709.0, 6000.939990600213, 6031.69841507914, 6040.275166979991, 6068.969655151873, 6009.36901625323, 6027.21646185993, 6027.30685971119, 6029.728662210124, 6033.366496517802, 5719.2279042328755, 5922.318933322551, 5922.466977972003, 5922.644641321534, 5925.9407405925385, 6033.698315084316, 6035.245594300713, 6035.792841431643, 6048.969755151196, 6051.33435322123, 5918.23063001807, 5934.19888315072, 5941.346451890202, 5958.553108516965, 5969.73136208863], "value": 4440.049855038439, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.4200975297787, 814.3770015937807, 834.0158612836852, 848.7835601921516, 891.046580159229, 15570.22148892555, 16278.91860540697, 16450.75323870143, 16549.75175372369, 16579.91710041448, 13301.201927884335, 13371.130876493022, 13378.59864204073, 13463.46146154155, 13477.730445391086, 709.2411120101493, 843.6836186430058, 848.2832006954129, 862.3790870573177, 871.0114020586648, 857.3098655582254, 858.2790456016944, 862.8791969124328, 868.8045189832269, 870.4037734152095, 913.2055112052524, 915.0940568836837, 916.2029034739786, 916.7662246127228, 916.9816603667923, 892.9776755581097, 899.8335307968047, 900.2842740021666, 901.2789768185459, 901.5852707754441, 669.959802411852, 670.6847781542667, 674.6694119881272, 674.8751480975986, 675.1594265139884, 15361.308741106564, 15380.154091524962, 15418.922905385401, 15452.768208476882, 15465.458708945245, 15877.419322763606, 16278.26747796352, 16556.172191390502, 16635.251413686412, 16717.83282167175, 12892.0, 12899.35503224835, 13052.869471305261, 13105.737885242243, 13240.53658121961, 4036.8788936331957, 4057.69567282455, 4070.3690927906223, 4108.342665173588, 4154.31453810121, 74511.0, 74862.62568687122, 75492.0, 75817.0, 76103.0, 12479.87520124787, 12565.811512827315, 12613.810792838114, 12657.873421265853, 12740.299283539494, 22426.215082472034, 22522.887385562968, 22543.0982760691, 22558.887205563868, 22675.773242267365, 9248.676296329731, 9336.439813611205, 9344.953275233716, 9363.063693630582, 9421.104995025462, 4973.2042873140845, 5020.3724534433195, 5059.139946209153, 5080.085584594808, 5211.452797456288, 3528.135606776305, 3638.181409182913, 3641.1625326175126, 3647.0335361129323, 3660.7071434285194, 625.343389441085, 627.7583130494793, 643.0836058616546, 662.6719773712043, 666.4634968850025, 670.1187937861696, 745.6271864067966, 749.688879115172, 752.3116348541133, 773.5745340062942, 10694.144468442506, 10936.671899843017, 11022.228444008842, 11036.11711063113, 11141.610043648434, 692.5013989927244, 725.3399406540024, 746.8879668049836, 759.6315786843377, 767.5739964319856, 5286.841394758163, 5501.972490137604, 5534.142207957773, 5628.9586426510405, 5668.433156684381, 130671.0, 131033.34483327523, 131115.34442327727, 132237.67762322447, 133238.0, 99312.5034374838, 100598.4970075145, 102325.0, 106073.46963265134, 106811.46594266979, 55761.163582546294, 76263.23736762672, 89873.55063224773, 92728.0, 94500.0, 10321.48392580353, 10504.632337868137, 10626.415547144981, 10728.463576820972, 10956.506957186786, 37635.62364376321, 38999.41500877546, 42517.0, 45533.0, 51110.0, 70418.64790676013, 72586.27413726006, 75109.0, 75759.62120189363, 75871.62064189644, 12186.329751863732, 12365.319907405179, 13425.0, 13554.051216414757, 13690.178589284675, 15240.237988100329, 15671.921640391725, 15965.44120955761, 16096.597585060466, 17079.573010674834, 13827.654308641962, 13919.164850109026, 14049.22729249901, 15705.764413534034, 15706.0, 13788.061883662327, 13966.36973474313, 14037.929810350883, 14795.556133316019, 15144.0, 14692.265386730407, 14762.188079655722, 14965.027273227206, 15001.099934003994, 15106.320215590544, 11407.600733974272, 11430.428478576205, 11434.542618295507, 11710.648680539598, 11957.342346171044, 11441.256318339614, 11561.364124973206, 11766.411679415824, 12085.456154472893, 12401.689957751129], "value": 7951.570556913176, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 106.0, 111.0, 110.0, 114.0, 112.0, 110.0, 110.0, 110.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 154.0, 192.0, 125.0, 157.0, 148.0, 126.0, 176.0, 124.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 160.0, 164.0, 164.0, 161.0, 163.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 175.0, 77.0, 78.0, 76.0, 75.0, 160.0, 78.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 148.0, 86.0, 85.0, 84.0, 139.0, 84.0, 85.0, 149.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 146.0, 147.0, 148.0, 148.0, 146.0, 149.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 52.0, 53.0, 51.0, 52.0, 51.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 80.0, 84.0, 79.0, 78.0, 78.0, 79.0, 100.0, 85.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 117.0, 124.0, 132.0, 118.0, 121.0, 124.0, 129.0, 128.0, 122.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 154.0, 154.0, 161.0, 159.0, 154.0, 165.0, 157.0, 155.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 61.0, 61.0, 60.0, 61.0, 64.0, 64.0, 61.0, 61.0], "value": 62.2, "unit": "score"}]}]} 03:22:57 INFO - Return code: 0 03:22:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:22:57 ERROR - # TBPL SUCCESS # 03:22:57 INFO - Running post-action listener: _resource_record_post_action 03:22:57 INFO - ##### 03:22:57 INFO - ##### Finished run-tests step (success) 03:22:57 INFO - ##### 03:22:57 INFO - Running post-run listener: _resource_record_post_run 03:22:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8183808; Write bytes: 391999488; Read time: 1768; Write time: 366748 03:22:57 INFO - TinderboxPrint: CPU usage
13.4% 03:22:57 INFO - TinderboxPrint: I/O read bytes / time
8,183,808 / 1,768 03:22:57 INFO - TinderboxPrint: I/O write bytes / time
391,999,488 / 366,748 03:22:57 INFO - TinderboxPrint: CPU idle
8,222.2 (86.6%) 03:22:57 INFO - TinderboxPrint: CPU user
1,213.4 (12.8%) 03:22:57 INFO - TinderboxPrint: Swap in / out
0 / 0 03:22:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15613952; Read time: 0; Write time: 3268 03:22:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6291456; Write bytes: 376385536; Read time: 1448; Write time: 363480 03:22:58 INFO - Running post-run listener: _upload_blobber_files 03:22:58 INFO - Blob upload gear active. 03:22:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:22:58 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 03:22:58 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'] 03:22:58 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 03:22:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:22:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:59 INFO - (blobuploader) - INFO - Done attempting. 03:22:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:22:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:23:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:00 INFO - (blobuploader) - INFO - Done attempting. 03:23:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:23:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:23:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:04 INFO - (blobuploader) - INFO - Done attempting. 03:23:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:23:04 INFO - Return code: 0 03:23:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:23:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:23:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9928094de3ba4234c2138abda9489f68e14adee741b97c8e4e4fc4ca91b0ae6142523ca3caacbe4ef0a6473a62cad84faf75f00399e76db08e5b9dcf478b1a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/919d30aa0a891703e8a5e45120081019bdc3013d873b6639618770bc90691bb2b2429b437a421c945c36a249cc2a9ca7c9930e9a15c463ee185345bd8d839140", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cf868e2124c661c1215c62e5687c5fbaf6a5c6c0d95939d6a0ac2a28bc50cc0267f9d6dec91cf292f9320bf8d760108e09d4641b140b35def9e812b94021606"} 03:23:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:23:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:23:04 INFO - Contents: 03:23:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9928094de3ba4234c2138abda9489f68e14adee741b97c8e4e4fc4ca91b0ae6142523ca3caacbe4ef0a6473a62cad84faf75f00399e76db08e5b9dcf478b1a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/919d30aa0a891703e8a5e45120081019bdc3013d873b6639618770bc90691bb2b2429b437a421c945c36a249cc2a9ca7c9930e9a15c463ee185345bd8d839140", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cf868e2124c661c1215c62e5687c5fbaf6a5c6c0d95939d6a0ac2a28bc50cc0267f9d6dec91cf292f9320bf8d760108e09d4641b140b35def9e812b94021606"} 03:23:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:23:04 INFO - Copying logs to upload dir... 03:23:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:23:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.848693 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-30 03:23:04.080152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:23:04.083720) ========= 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=0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9928094de3ba4234c2138abda9489f68e14adee741b97c8e4e4fc4ca91b0ae6142523ca3caacbe4ef0a6473a62cad84faf75f00399e76db08e5b9dcf478b1a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/919d30aa0a891703e8a5e45120081019bdc3013d873b6639618770bc90691bb2b2429b437a421c945c36a249cc2a9ca7c9930e9a15c463ee185345bd8d839140", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cf868e2124c661c1215c62e5687c5fbaf6a5c6c0d95939d6a0ac2a28bc50cc0267f9d6dec91cf292f9320bf8d760108e09d4641b140b35def9e812b94021606"} build_url:https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011025 build_url: 'https://queue.taskcluster.net/v1/task/f1OtShs4TkuCRKU9u8J4NA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9928094de3ba4234c2138abda9489f68e14adee741b97c8e4e4fc4ca91b0ae6142523ca3caacbe4ef0a6473a62cad84faf75f00399e76db08e5b9dcf478b1a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/919d30aa0a891703e8a5e45120081019bdc3013d873b6639618770bc90691bb2b2429b437a421c945c36a249cc2a9ca7c9930e9a15c463ee185345bd8d839140", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6cf868e2124c661c1215c62e5687c5fbaf6a5c6c0d95939d6a0ac2a28bc50cc0267f9d6dec91cf292f9320bf8d760108e09d4641b140b35def9e812b94021606"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:23:04.108142) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:23:04.108453) ========= 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=0333a256a5e4f052382dd180000001b1-1469869899.393160-329911598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:23:04.194058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:23:04.194387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:23:04.194661) ========= ========= Total master_lag: 0.17 =========