builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1467048902.91 results: success (0) buildid: 20160627075218 builduid: 3a32e27063da48c3a4915fe84f33b85c revision: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:02.905440) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:02.905955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:02.906260) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:02.924663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:02.925003) ========= 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=af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 10:35:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-06-27 10:35:03 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.011590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.011911) ========= 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=af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.060876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.061232) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 --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 c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 --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=af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 10:35:03,285 truncating revision to first 12 chars 2016-06-27 10:35:03,285 Setting DEBUG logging. 2016-06-27 10:35:03,285 attempt 1/10 2016-06-27 10:35:03,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c0c2a83ca397?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 10:35:03,586 unpacking tar archive at: mozilla-aurora-c0c2a83ca397/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678807 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.753403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.753747) ========= script_repo_revision: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.754288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.754556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 10:35:03.764923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-27 10:35:03.765209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:35:04 INFO - MultiFileLogger online at 20160627 10:35:04 in /builds/slave/test 10:35:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:35:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:35:04 INFO - {'append_to_log': False, 10:35:04 INFO - 'base_work_dir': '/builds/slave/test', 10:35:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:35:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:35:04 INFO - 'branch': 'Mozilla-Aurora', 10:35:04 INFO - 'buildbot_json_path': 'buildprops.json', 10:35:04 INFO - 'config_files': ('talos/linux_config.py',), 10:35:04 INFO - 'default_actions': ('clobber', 10:35:04 INFO - 'read-buildbot-config', 10:35:04 INFO - 'download-and-extract', 10:35:04 INFO - 'populate-webroot', 10:35:04 INFO - 'create-virtualenv', 10:35:04 INFO - 'install', 10:35:04 INFO - 'run-tests'), 10:35:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:35:04 INFO - 'download_minidump_stackwalk': True, 10:35:04 INFO - 'download_symbols': 'ondemand', 10:35:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:35:04 INFO - 'tooltool.py': '/tools/tooltool.py', 10:35:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:35:04 INFO - '/tools/misc-python/virtualenv.py')}, 10:35:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:35:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:35:04 INFO - 'installer_path': 'installer.exe', 10:35:04 INFO - 'log_level': 'info', 10:35:04 INFO - 'log_name': 'talos', 10:35:04 INFO - 'log_to_console': True, 10:35:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:35:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:35:04 INFO - 'opt_config_files': (), 10:35:04 INFO - 'pip_index': False, 10:35:04 INFO - 'sps_profile': False, 10:35:04 INFO - 'sps_profile_interval': 0, 10:35:04 INFO - 'suite': 'dromaeojs', 10:35:04 INFO - 'system_bits': '32', 10:35:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:35:04 INFO - 'title': 'talos-linux64-ix-020', 10:35:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:35:04 INFO - 'use_talos_json': True, 10:35:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:35:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:35:04 INFO - 'work_dir': 'build'} 10:35:04 INFO - ##### 10:35:04 INFO - ##### Running clobber step. 10:35:04 INFO - ##### 10:35:04 INFO - Running pre-action listener: _resource_record_pre_action 10:35:04 INFO - Running main action method: clobber 10:35:04 INFO - rmtree: /builds/slave/test/build 10:35:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:35:04 INFO - Running post-action listener: _resource_record_post_action 10:35:04 INFO - ##### 10:35:04 INFO - ##### Finished clobber step (success) 10:35:04 INFO - ##### 10:35:04 INFO - ##### 10:35:04 INFO - ##### Running read-buildbot-config step. 10:35:04 INFO - ##### 10:35:04 INFO - Running pre-action listener: _resource_record_pre_action 10:35:04 INFO - Running main action method: read_buildbot_config 10:35:04 INFO - Using buildbot properties: 10:35:04 INFO - { 10:35:04 INFO - "project": "", 10:35:04 INFO - "product": "firefox", 10:35:04 INFO - "script_repo_revision": "production", 10:35:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:35:04 INFO - "repository": "", 10:35:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:35:04 INFO - "buildid": "20160627075218", 10:35:04 INFO - "pgo_build": "True", 10:35:04 INFO - "basedir": "/builds/slave/test", 10:35:04 INFO - "buildnumber": 581, 10:35:04 INFO - "slavename": "talos-linux64-ix-020", 10:35:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:35:04 INFO - "platform": "ubuntu64_hw", 10:35:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:35:04 INFO - "branch": "mozilla-aurora", 10:35:04 INFO - "repo_path": "releases/mozilla-aurora", 10:35:04 INFO - "revision": "c0c2a83ca3973e5732b1d739ab9fefa551e3cd05", 10:35:04 INFO - "stage_platform": "linux64-pgo", 10:35:04 INFO - "builduid": "3a32e27063da48c3a4915fe84f33b85c", 10:35:04 INFO - "slavebuilddir": "test" 10:35:04 INFO - } 10:35:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:35:04 INFO - Running post-action listener: _resource_record_post_action 10:35:04 INFO - ##### 10:35:04 INFO - ##### Finished read-buildbot-config step (success) 10:35:04 INFO - ##### 10:35:04 INFO - ##### 10:35:04 INFO - ##### Running download-and-extract step. 10:35:04 INFO - ##### 10:35:04 INFO - Running pre-action listener: _resource_record_pre_action 10:35:04 INFO - Running main action method: download_and_extract 10:35:04 INFO - mkdir: /builds/slave/test/build/tests 10:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:04 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:35:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:35:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:35:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:35:05 INFO - Downloaded 1361 bytes. 10:35:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:35:05 INFO - Using the following test package requirements: 10:35:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:35:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:35:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:35:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'jsshell-linux-x86_64.zip'], 10:35:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:35:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:35:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:35:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:35:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:35:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:35:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:05 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:35:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:35:06 INFO - Downloaded 24522704 bytes. 10:35:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:35:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:35:07 INFO - Return code: 0 10:35:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:07 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:35:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:35:10 INFO - Downloaded 24522704 bytes. 10:35:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:35:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:35:11 INFO - Return code: 0 10:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:11 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:35:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:35:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:35:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:35:13 INFO - Downloaded 10833369 bytes. 10:35:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:35:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:35:13 INFO - Return code: 0 10:35: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')]} 10:35:13 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:35:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:35:14 INFO - Downloaded 63613651 bytes. 10:35:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:14 INFO - mkdir: /builds/slave/test/properties 10:35:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:35:14 INFO - Writing to file /builds/slave/test/properties/build_url 10:35:14 INFO - Contents: 10:35:14 INFO - build_url:https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:35:15 INFO - Running post-action listener: _resource_record_post_action 10:35:15 INFO - Running post-action listener: set_extra_try_arguments 10:35:15 INFO - ##### 10:35:15 INFO - ##### Finished download-and-extract step (success) 10:35:15 INFO - ##### 10:35:15 INFO - ##### 10:35:15 INFO - ##### Running populate-webroot step. 10:35:15 INFO - ##### 10:35:15 INFO - Running pre-action listener: _resource_record_pre_action 10:35:15 INFO - Running main action method: populate_webroot 10:35:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:35:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:35:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:35:15 INFO - '--tppagecycles', 10:35:15 INFO - '7'], 10:35:15 INFO - 'tests': ['tsvgm']}}, 10:35:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:35:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:35:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:35:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:35:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['damp', 'tps']}, 10:35:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'tests': ['damp', 'tps']}, 10:35:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['dromaeo_dom']}, 10:35:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:35:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['a11yr', 10:35:15 INFO - 'ts_paint', 10:35:15 INFO - 'tpaint', 10:35:15 INFO - 'sessionrestore', 10:35:15 INFO - 'sessionrestore_no_auto_restore', 10:35:15 INFO - 'tabpaint']}, 10:35:15 INFO - 'other-e10s': {'tests': ['a11yr', 10:35:15 INFO - 'ts_paint', 10:35:15 INFO - 'tpaint', 10:35:15 INFO - 'sessionrestore', 10:35:15 INFO - 'sessionrestore_no_auto_restore', 10:35:15 INFO - 'tabpaint']}, 10:35:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:35:15 INFO - 'ts_paint', 10:35:15 INFO - 'tpaint', 10:35:15 INFO - 'sessionrestore', 10:35:15 INFO - 'sessionrestore_no_auto_restore', 10:35:15 INFO - 'tabpaint']}, 10:35:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:35:15 INFO - 'ts_paint', 10:35:15 INFO - 'tpaint', 10:35:15 INFO - 'sessionrestore', 10:35:15 INFO - 'sessionrestore_no_auto_restore', 10:35:15 INFO - 'tabpaint']}, 10:35:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['a11yr', 10:35:15 INFO - 'ts_paint', 10:35:15 INFO - 'tpaint', 10:35:15 INFO - 'sessionrestore', 10:35:15 INFO - 'sessionrestore_no_auto_restore', 10:35:15 INFO - 'tabpaint']}, 10:35:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['a11yr', 10:35:15 INFO - 'ts_paint', 10:35:15 INFO - 'tpaint', 10:35:15 INFO - 'sessionrestore', 10:35:15 INFO - 'sessionrestore_no_auto_restore', 10:35:15 INFO - 'tabpaint']}, 10:35:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['tsvgx', 10:35:15 INFO - 'tsvgr_opacity', 10:35:15 INFO - 'tart', 10:35:15 INFO - 'tscrollx', 10:35:15 INFO - 'cart']}, 10:35:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:35:15 INFO - 'tsvgr_opacity', 10:35:15 INFO - 'tart', 10:35:15 INFO - 'tscrollx', 10:35:15 INFO - 'cart']}, 10:35:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'talos_options': ['--disable-e10s'], 10:35:15 INFO - 'tests': ['tp5o']}, 10:35:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'tests': ['tp5o']}, 10:35:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'talos_options': ['--disable-e10s', 10:35:15 INFO - '--xperf_path', 10:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:15 INFO - 'tests': ['tp5n']}, 10:35:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:15 INFO - 'talos_options': ['--xperf_path', 10:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:15 INFO - 'tests': ['tp5n']}}, 10:35:15 INFO - 'talos.zip': {'path': '', 10:35:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:35:15 INFO - Running post-action listener: _resource_record_post_action 10:35:15 INFO - ##### 10:35:15 INFO - ##### Finished populate-webroot step (success) 10:35:15 INFO - ##### 10:35:15 INFO - ##### 10:35:15 INFO - ##### Running create-virtualenv step. 10:35:15 INFO - ##### 10:35:15 INFO - Running pre-action listener: _resource_record_pre_action 10:35:15 INFO - Running main action method: create_virtualenv 10:35:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:35:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:35:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:35:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:35:15 INFO - Using real prefix '/usr' 10:35:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:35:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:35:18 INFO - Installing pip.................done. 10:35:18 INFO - Return code: 0 10:35:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:35:18 INFO - Using env: {'DISPLAY': ':0', 10:35:18 INFO - 'HOME': '/home/cltbld', 10:35:18 INFO - 'LANG': 'en_US.UTF-8', 10:35:18 INFO - 'LANGUAGE': 'en_US:en', 10:35:18 INFO - 'LOGNAME': 'cltbld', 10:35:18 INFO - 'MAIL': '/var/mail/cltbld', 10:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:18 INFO - 'MOZ_NO_REMOTE': '1', 10:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:18 INFO - 'NO_EM_RESTART': '1', 10:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:18 INFO - 'PWD': '/builds/slave/test', 10:35:18 INFO - 'SHELL': '/bin/bash', 10:35:18 INFO - 'SHLVL': '1', 10:35:18 INFO - 'TERM': 'linux', 10:35:18 INFO - 'TMOUT': '86400', 10:35:18 INFO - 'USER': 'cltbld', 10:35:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:18 INFO - '_': '/tools/buildbot/bin/python'} 10:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:35:18 INFO - Cleaning up... 10:35:18 INFO - Return code: 0 10:35:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:35:18 INFO - Using env: {'DISPLAY': ':0', 10:35:18 INFO - 'HOME': '/home/cltbld', 10:35:18 INFO - 'LANG': 'en_US.UTF-8', 10:35:18 INFO - 'LANGUAGE': 'en_US:en', 10:35:18 INFO - 'LOGNAME': 'cltbld', 10:35:18 INFO - 'MAIL': '/var/mail/cltbld', 10:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:18 INFO - 'MOZ_NO_REMOTE': '1', 10:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:18 INFO - 'NO_EM_RESTART': '1', 10:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:18 INFO - 'PWD': '/builds/slave/test', 10:35:18 INFO - 'SHELL': '/bin/bash', 10:35:18 INFO - 'SHLVL': '1', 10:35:18 INFO - 'TERM': 'linux', 10:35:18 INFO - 'TMOUT': '86400', 10:35:18 INFO - 'USER': 'cltbld', 10:35:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:18 INFO - '_': '/tools/buildbot/bin/python'} 10:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:18 INFO - Downloading/unpacking psutil>=3.1.1 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:35:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:20 INFO - Installing collected packages: psutil 10:35:20 INFO - Running setup.py install for psutil 10:35:20 INFO - building 'psutil._psutil_linux' extension 10:35:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:35:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:35:20 INFO - building 'psutil._psutil_posix' extension 10:35:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:35:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:35:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:21 INFO - Successfully installed psutil 10:35:21 INFO - Cleaning up... 10:35:21 INFO - Return code: 0 10:35:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:21 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:35:21 INFO - Using env: {'DISPLAY': ':0', 10:35:21 INFO - 'HOME': '/home/cltbld', 10:35:21 INFO - 'LANG': 'en_US.UTF-8', 10:35:21 INFO - 'LANGUAGE': 'en_US:en', 10:35:21 INFO - 'LOGNAME': 'cltbld', 10:35:21 INFO - 'MAIL': '/var/mail/cltbld', 10:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:21 INFO - 'MOZ_NO_REMOTE': '1', 10:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:21 INFO - 'NO_EM_RESTART': '1', 10:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:21 INFO - 'PWD': '/builds/slave/test', 10:35:21 INFO - 'SHELL': '/bin/bash', 10:35:21 INFO - 'SHLVL': '1', 10:35:21 INFO - 'TERM': 'linux', 10:35:21 INFO - 'TMOUT': '86400', 10:35:21 INFO - 'USER': 'cltbld', 10:35:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:21 INFO - '_': '/tools/buildbot/bin/python'} 10:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:35:23 INFO - Installing collected packages: mozsystemmonitor 10:35:23 INFO - Running setup.py install for mozsystemmonitor 10:35:23 INFO - Successfully installed mozsystemmonitor 10:35:23 INFO - Cleaning up... 10:35:23 INFO - Return code: 0 10:35:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:23 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:35:23 INFO - Using env: {'DISPLAY': ':0', 10:35:23 INFO - 'HOME': '/home/cltbld', 10:35:23 INFO - 'LANG': 'en_US.UTF-8', 10:35:23 INFO - 'LANGUAGE': 'en_US:en', 10:35:23 INFO - 'LOGNAME': 'cltbld', 10:35:23 INFO - 'MAIL': '/var/mail/cltbld', 10:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:23 INFO - 'MOZ_NO_REMOTE': '1', 10:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:23 INFO - 'NO_EM_RESTART': '1', 10:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:23 INFO - 'PWD': '/builds/slave/test', 10:35:23 INFO - 'SHELL': '/bin/bash', 10:35:23 INFO - 'SHLVL': '1', 10:35:23 INFO - 'TERM': 'linux', 10:35:23 INFO - 'TMOUT': '86400', 10:35:23 INFO - 'USER': 'cltbld', 10:35:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:23 INFO - '_': '/tools/buildbot/bin/python'} 10:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:23 INFO - Downloading/unpacking jsonschema==2.5.1 10:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:35:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:25 INFO - Downloading functools32-3.2.3-2.tar.gz 10:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:35:25 INFO - warning: no files found matching '*.txt' 10:35:25 INFO - no previously-included directories found matching 'build' 10:35:25 INFO - no previously-included directories found matching 'dist' 10:35:25 INFO - no previously-included directories found matching '.git*' 10:35:25 INFO - Installing collected packages: jsonschema, functools32 10:35:25 INFO - Running setup.py install for functools32 10:35:26 INFO - warning: no files found matching '*.txt' 10:35:26 INFO - no previously-included directories found matching 'build' 10:35:26 INFO - no previously-included directories found matching 'dist' 10:35:26 INFO - no previously-included directories found matching '.git*' 10:35:26 INFO - Successfully installed jsonschema functools32 10:35:26 INFO - Cleaning up... 10:35:26 INFO - Return code: 0 10:35:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:26 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:35:26 INFO - Using env: {'DISPLAY': ':0', 10:35:26 INFO - 'HOME': '/home/cltbld', 10:35:26 INFO - 'LANG': 'en_US.UTF-8', 10:35:26 INFO - 'LANGUAGE': 'en_US:en', 10:35:26 INFO - 'LOGNAME': 'cltbld', 10:35:26 INFO - 'MAIL': '/var/mail/cltbld', 10:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:26 INFO - 'MOZ_NO_REMOTE': '1', 10:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:26 INFO - 'NO_EM_RESTART': '1', 10:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:26 INFO - 'PWD': '/builds/slave/test', 10:35:26 INFO - 'SHELL': '/bin/bash', 10:35:26 INFO - 'SHLVL': '1', 10:35:26 INFO - 'TERM': 'linux', 10:35:26 INFO - 'TMOUT': '86400', 10:35:26 INFO - 'USER': 'cltbld', 10:35:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:26 INFO - '_': '/tools/buildbot/bin/python'} 10:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:26 INFO - Downloading/unpacking blobuploader==1.2.4 10:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:35:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:35:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:28 INFO - Downloading docopt-0.6.1.tar.gz 10:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:35:28 INFO - Installing collected packages: blobuploader, requests, docopt 10:35:28 INFO - Running setup.py install for blobuploader 10:35:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:35:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:35:29 INFO - Running setup.py install for requests 10:35:29 INFO - Running setup.py install for docopt 10:35:29 INFO - Successfully installed blobuploader requests docopt 10:35:29 INFO - Cleaning up... 10:35:29 INFO - Return code: 0 10:35:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:29 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:35:29 INFO - Using env: {'DISPLAY': ':0', 10:35:29 INFO - 'HOME': '/home/cltbld', 10:35:29 INFO - 'LANG': 'en_US.UTF-8', 10:35:29 INFO - 'LANGUAGE': 'en_US:en', 10:35:29 INFO - 'LOGNAME': 'cltbld', 10:35:29 INFO - 'MAIL': '/var/mail/cltbld', 10:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:29 INFO - 'MOZ_NO_REMOTE': '1', 10:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:29 INFO - 'NO_EM_RESTART': '1', 10:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:29 INFO - 'PWD': '/builds/slave/test', 10:35:29 INFO - 'SHELL': '/bin/bash', 10:35:29 INFO - 'SHLVL': '1', 10:35:29 INFO - 'TERM': 'linux', 10:35:29 INFO - 'TMOUT': '86400', 10:35:29 INFO - 'USER': 'cltbld', 10:35:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:29 INFO - '_': '/tools/buildbot/bin/python'} 10:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:29 INFO - Running setup.py (path:/tmp/pip-qMyd5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:29 INFO - Running setup.py (path:/tmp/pip-Bv1Ox4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:29 INFO - Running setup.py (path:/tmp/pip-agwn48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:30 INFO - Running setup.py (path:/tmp/pip-iyrFhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:30 INFO - Running setup.py (path:/tmp/pip-yIe0np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:30 INFO - Running setup.py (path:/tmp/pip-xi8wjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:30 INFO - Running setup.py (path:/tmp/pip-dIoShO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:30 INFO - Running setup.py (path:/tmp/pip-_2XIt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:30 INFO - Running setup.py (path:/tmp/pip-Sa3oiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:30 INFO - Running setup.py (path:/tmp/pip-dQefOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:30 INFO - Running setup.py (path:/tmp/pip-9fjmtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:30 INFO - Running setup.py (path:/tmp/pip-n3ov5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:30 INFO - Running setup.py (path:/tmp/pip-_ETXIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:30 INFO - Running setup.py (path:/tmp/pip-emTmYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:30 INFO - Running setup.py (path:/tmp/pip-lYh4SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:30 INFO - Running setup.py (path:/tmp/pip-zPoKP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:30 INFO - Running setup.py (path:/tmp/pip-y4oO6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:35:30 INFO - Running setup.py install for manifestparser 10:35:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Running setup.py install for mozcrash 10:35:31 INFO - Running setup.py install for mozdebug 10:35:31 INFO - Running setup.py install for mozdevice 10:35:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Running setup.py install for mozfile 10:35:31 INFO - Running setup.py install for mozhttpd 10:35:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Running setup.py install for mozinfo 10:35:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Running setup.py install for mozInstall 10:35:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:35:31 INFO - Running setup.py install for mozleak 10:35:31 INFO - Running setup.py install for mozlog 10:35:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:35:32 INFO - Running setup.py install for moznetwork 10:35:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:35:32 INFO - Running setup.py install for mozprocess 10:35:32 INFO - Running setup.py install for mozprofile 10:35:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:35:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:35:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:35:32 INFO - Running setup.py install for mozrunner 10:35:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:35:32 INFO - Running setup.py install for mozscreenshot 10:35:32 INFO - Running setup.py install for moztest 10:35:32 INFO - Running setup.py install for mozversion 10:35:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:35:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:35:32 INFO - Cleaning up... 10:35:32 INFO - Return code: 0 10:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:32 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:35:32 INFO - Using env: {'DISPLAY': ':0', 10:35:32 INFO - 'HOME': '/home/cltbld', 10:35:32 INFO - 'LANG': 'en_US.UTF-8', 10:35:32 INFO - 'LANGUAGE': 'en_US:en', 10:35:32 INFO - 'LOGNAME': 'cltbld', 10:35:32 INFO - 'MAIL': '/var/mail/cltbld', 10:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:32 INFO - 'MOZ_NO_REMOTE': '1', 10:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:32 INFO - 'NO_EM_RESTART': '1', 10:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:32 INFO - 'PWD': '/builds/slave/test', 10:35:32 INFO - 'SHELL': '/bin/bash', 10:35:32 INFO - 'SHLVL': '1', 10:35:32 INFO - 'TERM': 'linux', 10:35:32 INFO - 'TMOUT': '86400', 10:35:32 INFO - 'USER': 'cltbld', 10:35:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:32 INFO - '_': '/tools/buildbot/bin/python'} 10:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:32 INFO - Running setup.py (path:/tmp/pip-T226Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:33 INFO - Running setup.py (path:/tmp/pip-8UyKgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:33 INFO - Running setup.py (path:/tmp/pip-PRpDSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:33 INFO - Running setup.py (path:/tmp/pip-tSWrm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:33 INFO - Running setup.py (path:/tmp/pip-3EmoJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:33 INFO - Running setup.py (path:/tmp/pip-Zs9oI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:33 INFO - Running setup.py (path:/tmp/pip-kspPV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:33 INFO - Running setup.py (path:/tmp/pip-eBLQZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:33 INFO - Running setup.py (path:/tmp/pip-rsTVBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:33 INFO - Running setup.py (path:/tmp/pip-6YNFAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:33 INFO - Running setup.py (path:/tmp/pip-MzUxtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:33 INFO - Running setup.py (path:/tmp/pip-Aj0IaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:33 INFO - Running setup.py (path:/tmp/pip-RD_SrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:33 INFO - Running setup.py (path:/tmp/pip-ToCjyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:34 INFO - Running setup.py (path:/tmp/pip-SI2coZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:34 INFO - Running setup.py (path:/tmp/pip-H6LzSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:34 INFO - Running setup.py (path:/tmp/pip-gPnySM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:36 INFO - Downloading blessings-1.6.tar.gz 10:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:36 INFO - Installing collected packages: blessings 10:35:36 INFO - Running setup.py install for blessings 10:35:36 INFO - Successfully installed blessings 10:35:36 INFO - Cleaning up... 10:35:36 INFO - Return code: 0 10:35:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:36 INFO - Reading from file tmpfile_stdout 10:35:36 INFO - Current package versions: 10:35:36 INFO - argparse == 1.2.1 10:35:36 INFO - blessings == 1.6 10:35:36 INFO - blobuploader == 1.2.4 10:35:36 INFO - docopt == 0.6.1 10:35:36 INFO - functools32 == 3.2.3-2 10:35:36 INFO - jsonschema == 2.5.1 10:35:36 INFO - manifestparser == 1.1 10:35:36 INFO - mozInstall == 1.12 10:35:36 INFO - mozcrash == 0.17 10:35:36 INFO - mozdebug == 0.1 10:35:36 INFO - mozdevice == 0.48 10:35:36 INFO - mozfile == 1.2 10:35:36 INFO - mozhttpd == 0.7 10:35:36 INFO - mozinfo == 0.9 10:35:36 INFO - mozleak == 0.1 10:35:36 INFO - mozlog == 3.2 10:35:36 INFO - moznetwork == 0.27 10:35:36 INFO - mozprocess == 0.22 10:35:36 INFO - mozprofile == 0.28 10:35:36 INFO - mozrunner == 6.11 10:35:36 INFO - mozscreenshot == 0.1 10:35:36 INFO - mozsystemmonitor == 0.3 10:35:36 INFO - moztest == 0.7 10:35:36 INFO - mozversion == 1.4 10:35:36 INFO - psutil == 3.1.1 10:35:36 INFO - requests == 1.2.3 10:35:36 INFO - wsgiref == 0.1.2 10:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:36 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:35:36 INFO - Using env: {'DISPLAY': ':0', 10:35:36 INFO - 'HOME': '/home/cltbld', 10:35:36 INFO - 'LANG': 'en_US.UTF-8', 10:35:36 INFO - 'LANGUAGE': 'en_US:en', 10:35:36 INFO - 'LOGNAME': 'cltbld', 10:35:36 INFO - 'MAIL': '/var/mail/cltbld', 10:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:36 INFO - 'MOZ_NO_REMOTE': '1', 10:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:36 INFO - 'NO_EM_RESTART': '1', 10:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:36 INFO - 'PWD': '/builds/slave/test', 10:35:36 INFO - 'SHELL': '/bin/bash', 10:35:36 INFO - 'SHLVL': '1', 10:35:36 INFO - 'TERM': 'linux', 10:35:36 INFO - 'TMOUT': '86400', 10:35:36 INFO - 'USER': 'cltbld', 10:35:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:36 INFO - '_': '/tools/buildbot/bin/python'} 10:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:35:36 INFO - Cleaning up... 10:35:36 INFO - Return code: 0 10:35:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:36 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:35:36 INFO - Using env: {'DISPLAY': ':0', 10:35:36 INFO - 'HOME': '/home/cltbld', 10:35:36 INFO - 'LANG': 'en_US.UTF-8', 10:35:36 INFO - 'LANGUAGE': 'en_US:en', 10:35:36 INFO - 'LOGNAME': 'cltbld', 10:35:36 INFO - 'MAIL': '/var/mail/cltbld', 10:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:36 INFO - 'MOZ_NO_REMOTE': '1', 10:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:36 INFO - 'NO_EM_RESTART': '1', 10:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:36 INFO - 'PWD': '/builds/slave/test', 10:35:36 INFO - 'SHELL': '/bin/bash', 10:35:36 INFO - 'SHLVL': '1', 10:35:36 INFO - 'TERM': 'linux', 10:35:36 INFO - 'TMOUT': '86400', 10:35:36 INFO - 'USER': 'cltbld', 10:35:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:36 INFO - '_': '/tools/buildbot/bin/python'} 10:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:37 INFO - Cleaning up... 10:35:37 INFO - Return code: 0 10:35:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:37 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 0x7f41da1d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, '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': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:35:37 INFO - Using env: {'DISPLAY': ':0', 10:35:37 INFO - 'HOME': '/home/cltbld', 10:35:37 INFO - 'LANG': 'en_US.UTF-8', 10:35:37 INFO - 'LANGUAGE': 'en_US:en', 10:35:37 INFO - 'LOGNAME': 'cltbld', 10:35:37 INFO - 'MAIL': '/var/mail/cltbld', 10:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:37 INFO - 'MOZ_NO_REMOTE': '1', 10:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:37 INFO - 'NO_EM_RESTART': '1', 10:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:37 INFO - 'PWD': '/builds/slave/test', 10:35:37 INFO - 'SHELL': '/bin/bash', 10:35:37 INFO - 'SHLVL': '1', 10:35:37 INFO - 'TERM': 'linux', 10:35:37 INFO - 'TMOUT': '86400', 10:35:37 INFO - 'USER': 'cltbld', 10:35:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:37 INFO - '_': '/tools/buildbot/bin/python'} 10:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:37 INFO - Downloading/unpacking flake8 10:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:35:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:35:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:35:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:35:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:35:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:35:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:35:39 INFO - no previously-included directories found matching 'docs/_build' 10:35:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:35:40 INFO - Running setup.py install for pep8 10:35:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:35:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:35:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:35:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:35:40 INFO - no previously-included directories found matching 'docs/_build' 10:35:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:35:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:35:40 INFO - Cleaning up... 10:35:40 INFO - Return code: 0 10:35:40 INFO - Running post-action listener: _resource_record_post_action 10:35:40 INFO - Running post-action listener: _start_resource_monitoring 10:35:40 INFO - Starting resource monitoring. 10:35:40 INFO - ##### 10:35:40 INFO - ##### Finished create-virtualenv step (success) 10:35:40 INFO - ##### 10:35:40 INFO - ##### 10:35:40 INFO - ##### Running install step. 10:35:40 INFO - ##### 10:35:40 INFO - Running pre-action listener: _resource_record_pre_action 10:35:40 INFO - Running main action method: install 10:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:40 INFO - Reading from file tmpfile_stdout 10:35:40 INFO - Detecting whether we're running mozinstall >=1.0... 10:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:35:40 INFO - Reading from file tmpfile_stdout 10:35:40 INFO - Output received: 10:35:40 INFO - Usage: mozinstall [options] installer 10:35:40 INFO - Options: 10:35:40 INFO - -h, --help show this help message and exit 10:35:40 INFO - -d DEST, --destination=DEST 10:35:40 INFO - Directory to install application into. [default: 10:35:40 INFO - "/builds/slave/test"] 10:35:40 INFO - --app=APP Application being installed. [default: firefox] 10:35:40 INFO - mkdir: /builds/slave/test/build/application 10:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:35:56 INFO - Reading from file tmpfile_stdout 10:35:56 INFO - Output received: 10:35:56 INFO - /builds/slave/test/build/application/firefox/firefox 10:35:56 INFO - Running post-action listener: _resource_record_post_action 10:35:56 INFO - ##### 10:35:56 INFO - ##### Finished install step (success) 10:35:56 INFO - ##### 10:35:56 INFO - ##### 10:35:56 INFO - ##### Running run-tests step. 10:35:56 INFO - ##### 10:35:56 INFO - Running pre-action listener: _resource_record_pre_action 10:35:56 INFO - Running main action method: run_tests 10:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:35:56 INFO - Python 2.7.3 10:35:56 INFO - Return code: 0 10:35:56 INFO - grabbing minidump binary from tooltool 10:35: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')]} 10:35:56 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 0x1814e20>, '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 0x18183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1818830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:35:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:35:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:35:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:35:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:35:56 INFO - Return code: 0 10:35:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:35:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:35:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:35:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:35:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:35:57 INFO - Return code: 0 10:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:35:57 INFO - Using env: {'DISPLAY': ':0', 10:35:57 INFO - 'HOME': '/home/cltbld', 10:35:57 INFO - 'LANG': 'en_US.UTF-8', 10:35:57 INFO - 'LANGUAGE': 'en_US:en', 10:35:57 INFO - 'LOGNAME': 'cltbld', 10:35:57 INFO - 'MAIL': '/var/mail/cltbld', 10:35:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:35:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:57 INFO - 'MOZ_NO_REMOTE': '1', 10:35:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:35:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:57 INFO - 'NO_EM_RESTART': '1', 10:35:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:57 INFO - 'PWD': '/builds/slave/test', 10:35:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:35:57 INFO - 'SHELL': '/bin/bash', 10:35:57 INFO - 'SHLVL': '1', 10:35:57 INFO - 'TERM': 'linux', 10:35:57 INFO - 'TMOUT': '86400', 10:35:57 INFO - 'USER': 'cltbld', 10:35:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249', 10:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:57 INFO - '_': '/tools/buildbot/bin/python'} 10:35:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:35:57 INFO - mozversion application_buildid: 20160627075218 10:35:57 INFO - mozversion application_changeset: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 10:35:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:35:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:35:57 INFO - mozversion application_name: Firefox 10:35:57 INFO - mozversion application_remotingname: firefox-dev 10:35:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:35:57 INFO - mozversion application_vendor: Mozilla 10:35:57 INFO - mozversion application_version: 49.0a2 10:35:57 INFO - mozversion platform_buildid: 20160627075218 10:35:57 INFO - mozversion platform_changeset: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 10:35:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:35:57 INFO - mozversion platform_version: 49.0a2 10:35:57 INFO - using testdate: 1467048957 10:35:57 INFO - actual date: 1467048957 10:35:57 INFO - starting webserver on 'localhost:46756' 10:35:57 INFO - SUITE-START | Running 2 tests 10:35:57 INFO - TEST-START | dromaeo_css 10:35:57 INFO - operating with platform_type : linux_ 10:35:57 INFO - Initialising browser for dromaeo_css test... 10:35:57 INFO - TEST-INFO | started process 31840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCs9EXt/profile http://localhost:46756/getInfo.html) 10:36:02 INFO - PROCESS | 31840 | __metrics Screen width/height:1600/1200 10:36:02 INFO - PROCESS | 31840 | colorDepth:24 10:36:02 INFO - PROCESS | 31840 | Browser inner width/height: 1024/697 10:36:02 INFO - PROCESS | 31840 | __metrics 10:36:03 ERROR - PROCESS | 31840 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:36:04 INFO - PROCESS | 31840 | console.error: PushService: 10:36:04 INFO - PROCESS | 31840 | stateChangeProcessEnqueue: Error transitioning state 10:36:04 INFO - PROCESS | 31840 | UnknownError 10:36:04 INFO - TEST-INFO | 31840: exit 0 10:36:04 INFO - Browser initialized. 10:36:04 INFO - Running cycle 1/1 for dromaeo_css test... 10:36:04 INFO - TEST-INFO | started process 31932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCs9EXt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:16 INFO - PROCESS | 31932 | RSS: Main: 144969728 10:36:16 INFO - PROCESS | 31932 | 10:37:08 INFO - PROCESS | 31932 | 1467049028196 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:39:15 INFO - PROCESS | 31932 | Cycle 1(1): loaded http://localhost:46756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46756/tests/dromaeo/cssquery-ext.html) 10:39:16 INFO - PROCESS | 31932 | RSS: Main: 260161536 10:39:16 INFO - PROCESS | 31932 | 10:42:19 INFO - PROCESS | 31932 | Cycle 1(1): loaded http://localhost:46756/tests/dromaeo/cssquery-ext.html (next: http://localhost:46756/tests/dromaeo/cssquery-jquery.html) 10:42:20 INFO - PROCESS | 31932 | RSS: Main: 231976960 10:42:20 INFO - PROCESS | 31932 | 10:45:21 INFO - PROCESS | 31932 | Cycle 1(1): loaded http://localhost:46756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46756/tests/dromaeo/cssquery-mootools.html) 10:45:22 INFO - PROCESS | 31932 | RSS: Main: 230850560 10:45:22 INFO - PROCESS | 31932 | 10:48:24 INFO - PROCESS | 31932 | Cycle 1(1): loaded http://localhost:46756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46756/tests/dromaeo/cssquery-prototype.html) 10:48:24 INFO - PROCESS | 31932 | RSS: Main: 229355520 10:48:24 INFO - PROCESS | 31932 | 10:51:27 INFO - PROCESS | 31932 | Cycle 1(1): loaded http://localhost:46756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46756/tests/dromaeo/cssquery-yui.html) 10:51:28 INFO - PROCESS | 31932 | RSS: Main: 199311360 10:51:28 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | Cycle 1(1): loaded http://localhost:46756/tests/dromaeo/cssquery-yui.html (next: http://localhost:46756/tests/dromaeo/cssquery-dojo.html) 10:54:30 INFO - PROCESS | 31932 | RSS: Main: 256335872 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | __start_tp_report 10:54:30 INFO - PROCESS | 31932 | _x_x_mozilla_page_load 10:54:30 INFO - PROCESS | 31932 | _x_x_mozilla_page_load_details 10:54:30 INFO - PROCESS | 31932 | |i|pagename|runs| 10:54:30 INFO - PROCESS | 31932 | |0;dojo.html;3300.785448945818;3325.2850637113015;3343.7993720376785;3348.112750121217;3373.1567108222944;5496.615236933416;5576.944230557693;5579.995600791855;5599.832005039845;5607.299087614043;5537.612367134302;5595.804146854861;5597.104463285875;5599.132134519145;5642.633228840123;4977.228529577903;5028.472010438906;5053.873653158664;5079.822206222783;5113.386393632769;4934.555889969902;4976.2286845539;4991.301217829507;5028.446870844205;5107.029664363778;5005.274235235888;5039.042581909425;5059;5105.05556472052;5107.489251074881;5078.695278283278;5096.923546146811;5096.949030509684;5104.2088476286235;5126.41046279677;4767.356406885061;4917.582005529534;4973.15456372414;4999.325091112726;5047.520485553867;5459.781608735686;5485.177223416479;5486.067368547357;5493.423190564973;5497.505224529811;5950.077737950624;5956.761729530814;5957.880842383128;6024.608400453956;6084.148219249309;6044.335123136451;6089.77242061708;6114.205153330083;6114.449699527064;6120.357362476965;5691.601587888849;5708;5724.513416359573;5725;5732.340780810218;5956.761729530857;6010.4891084258325;6040.244969378828;6083.178770865877;6100.084987251859;5877.206577112121;5934.258217722785;5945.346011938684;5946.732397042144;5948.940510594839;5980.043193089172;5995.400459953969;6019;6032.276126864805;6041.124037014608;5756.309242890796;5877.559183061202;5878.323992740804;5930.644161350333;6017.819465416044;5982.952983228005;5983.730732117066;5986.161937328778;5987.401259874065;5996.190514280516;4538.909221815546;4574.519675434098;4581.541845815392;4587.036722288357;4612.561806628365;3978.4629075074495;4001.979990100031;4046.635802777764;4057.69567282455;4067.389891516237;5714.257146570919;5721.971390143106;5724.313082430135;5729.914051289151;5757.424257574209;5855.970720146372;5990.341062483123;6012.068129439944;6021.57848950578;6037.275526936708;5530.889382212334;5537.58468114893;5605.8037968671715;5680.602357834912;5712.6286791358425;5148.974255128775;5155.896882062338;5159.174532074925;5161.561267292247;5191.584673226208;6009.128676341906;6020.638761674313;6117.724702388403;6129.325774164839;6129.877402451926;5932.851678707894;6004.339522652417;6008.158857760004;6008.639481630941;6039.456448919618;6171.506279497539;6205.81382558524;6235.064740288993;6239.282482514387;6246;5757.453041961007;5847.619904706181;5890.352061273342;5895.793647222326;5906.497947674324;6004.0693692477735;6049.425304596057;6052.425019623129;6053.727582258897;6073.665948372882;5861.296644402699;5900.763969441175;5903.7048147593305;5905.35041145465;5908.172855800105;5637.379888212211;5734.569907256889;5786.42135786418;5795.739191736467;5875.794347197999;5735.483806457272;5748.511376533042;5750.7987220447085;5754.798582049608;5760.971195143998;5845.883082338414;5879.2944846618675;5885.5880088395115;5903.586748927705;5904.468597826216;5585.050541408052;5588.888222235614;5625.296837895263;5628.634138780966;5681 10:54:30 INFO - PROCESS | 31932 | |1;ext.html;605.1588292273738;639;653.3172834388064;664.2560332427681;666.6633350158171;32302.67697323026;45162.32256516151;45523.77238113813;45786;45793.31310030352;45718.77140614301;46428.76785616067;46457;46463.30305045418;46576;8256.504609723406;9061.999999999984;9214.585343659552;10682;10980.835287470694;10882;11015.614453494129;11017.28387654804;11017.614383496579;11018;11037.944810275938;11039.83440248397;11087.667369978913;11091.279066860669;11110.777784444306;8427.241548260656;10874.728131796728;11107.944460277728;11131.109511239081;11441.656750297505;10863;10914.781704365947;10921.672349829518;10925.890741092568;10928.125749939985;44208.778956105016;44472.555274447164;44601.33098003532;44602.77698611486;44640;3765.228128233733;3793.8861834144745;3902.9804850975847;3937.153511994935;4124.237016152021;33176.50235246473;33180;33755.83122084398;33840.83079584611;33916;4493.932591011137;4528.479224889147;4549.590536851666;4594.816207351702;4648.349231107613;376792;379845;379947.99999999726;380324;380917;37029;38036;62154.68922655358;62885.68557157185;62895.85520724037;40262;40330.395044074365;40367;40450.59549404468;40466.39300410496;16048.919755401148;17268.568285792706;17420.47738567845;17428.825711742975;17432;14196;14638.268086595628;14679.339429725687;14834.925825370805;14988.850111498963;9123.589438475285;9170.368963673436;9173.908260917438;9225.769355766026;9249.445033298023;3497.8076205808925;3517.120719820045;3518.3842827505086;3551.9289614207573;3569.8750543730844;1049.9055085042382;1071.0467683761458;1097.5609756097465;1143.8341440491083;1229.655696405008;32917.835410822794;32969.38450513572;33216.501752473734;33382.332353352795;33841.474022197755;1099.8185299425504;1114.7603265298;1196.7187710887933;1196.904247660185;1206.6741979665442;17541.386051488138;17678.46964591064;17867.821321786614;17882.195301211475;17883;581352;583154;586237;587527;587540;61942.38057619456;62435.37564624386;62552.374476254656;62566;62651.06023409653;1349.1432940083118;1439.9568012959628;1450.3835869755312;1499.6250937265684;1503.9924800375927;32705.672943270263;34082.82958585191;34217.315653687285;34300;34594.827025865714;50794.74602626963;51315.48684513107;51330.74334628303;51384;51460.485395145566;331651;334075;335665;336624;336900;26723.19830405091;28741.137765867057;29872.551911720908;30194.54708179423;30343.696563034086;45520;50565.74717126391;51841.481585185174;51892.740536297075;52398.47601523936;41335.586644133175;43186.78406607947;43260;43275.783621082956;43700.78149609231;42858.78570607127;43501.78249108734;43928.56071439372;46732;48146.759266203444;43288.78355608202;43862.78068609637;45000;45141.32288015616;45155.77422113;37251.254974899806;38694.61305387023;38706.206443064155;38996.805015974736;39005;29025.03399184223;29135.562966555095;29523.704762952097;29650.851745741995;29669.554956675234 10:54:30 INFO - PROCESS | 31932 | |2;jquery.html;427.8523909251308;429.50177793759246;434.34268650823026;441.20362745244836;448.699371421148;18713.532161695963;19782.505437364074;20280.29018984336;20671.379858604265;20818.583628327462;19792.30726924558;20228.39314820554;20252.29116980906;20272.29046983356;20316.085776140073;5678.659280443177;5898.469137777599;5937.851553711149;5941.376155503674;5942.6434413935085;5856.297244330686;5869.589128760988;5893.528517718593;5895.675737834417;5903.26209223847;5807.912881306784;5813.7383817728305;5822.068469044953;5833.941660583382;5838.678872662002;5746.425357464262;5881.029630111027;5884;5884.087966365241;5908.14331921869;5093.541581257705;5160.354955630546;5276.551493123089;5284.445133260991;5285.7357132143625;23465;23552.52894942109;23737.16919907795;24186.758132418803;24245.87877060621;2384.499255156419;2416.903323867043;2427.4780922101654;2687.6371689821817;3194.552762613213;14600.34298456572;14620.488282910048;14878.851211487854;14899.702005959929;15043.398264069425;2045.202371075282;2056.331692200041;2106.8630539014916;2143.046344376753;2171.0555908179836;77012;80836.59581702112;81142.59428702819;81318.59340703317;82652.17347826505;10961.725956850983;11171.83242251367;11252.324860508395;11422.428878556038;11560.364179970182;16026.358945642043;16093.839061609468;16158.838411615734;16183.433579824885;16191.190440477929;8585.957070214608;8708.52103134321;8798.692045778495;8835.381523293436;8917.73246802597;8537.724426609388;8607.784805379915;8797.956010219908;8798.692045778367;8953;6737.292584278678;6897.517173797786;6953.574517223957;6974.930250697529;7024.367806897404;1861.9534511637046;1957.549763554362;2043.754749430078;2086.6525159195903;2087.7807830177917;921.7879887625884;1016.2987538598344;1041.7916416716535;1063.3194755356578;1091.3233795046963;19342.226310947684;20101.597968040558;20109;20147.19411223564;20201.49496262576;1069.385103565453;1071.566015763617;1130.6268931252666;1144.1247445704043;1218.7623413434296;11234.550617975354;11592.188546801812;11733.823992640117;11833.822492662617;11843.763124737457;458933;466143;474714;479443;494672;63105;63195.68402158052;64752;82281;84196;995.711243739322;1045.7333379988206;1072.962446314391;1125.6904351303458;1126.9661910142709;16794.328226871276;17449.69127315431;17553;18313.359032434335;18700;42866.357004644335;43207.35188972105;43319.35020974751;43921;44354.77822610866;57214.42785572258;57931.71034144802;58215;60377.39622603718;61441.69279153576;8796.164364385373;8999.865002025106;9108.453492790453;9119.908800911906;9340.252779777737;13915.512957046454;13998.300084995913;14007.159570425807;14169.36237869319;14501.492447764278;11748.118891083373;12023.158378913393;12297.692557686129;12595.11834171636;12632.621021369374;12013.75972480528;12205.450754716237;12333.136680432284;12409.875901241234;12630.179038362478;12580.748385032432;12583.307918064595;12744.362781861055;12824.87175128274;12828.807567886675;7972.322352600094;8884.37809353339;8956.820863582821;8989.325800565115;9287.72136835896;11982.940085299517;12146.089043321963;12402.627921162379;12443.564475243324;12648.557300494438 10:54:30 INFO - PROCESS | 31932 | |3;mootools.html;1395.3441882315308;1525.229758971719;1554.9766753498695;1724.551616579689;1838.8253115953987;9221.58502867371;9589.952050239757;9612.423254604728;9953.800923981516;9956.850647240297;9573.425594464337;9809.068138526829;9809.70570882873;9816.705498835028;9840.458774767385;2218.4010317214343;2433.7444568320293;2449.546833835746;2462.6182941644074;2524.772770450659;2536.441982763798;2555.3356127406823;2563.6923569171727;2568.036986130201;2569.704483984338;2446.156076153733;2447.877606119687;2463.8398504097268;2467.592847180213;2468.950620987588;2199.7690242524463;2425.563398588253;2484.5403600333816;2485.42835147917;2500.72492025877;2376.7623237676266;2381.6546600742795;2385.0579021286667;2435.780779729833;2460.8400453970435;9372.250219982385;9421.104995025531;9428.434293942386;9445.102715242041;9461.19579835708;5624.803131890364;5768.480836724673;5781.103928891029;5784.16129661201;5785.768569257225;3508.5965114011706;3517.1383011162175;3590.856365745367;3710.3692372296773;3725.8137093145233;1248.9000879929583;1268.6511209417392;1286.7040580666405;1294.8057791331282;1320.3926193950795;14038.719225615532;14052.297385130805;14058.578242652635;14080.507182248572;14085.15489070659;5038.647294689336;5048.646594738333;5076.847694569169;5089.541941225308;5160.535551800356;11538.13463990204;11638.06895448362;11647.941760291314;11681.357525336189;11682.24065435744;5119.283300337956;5770.047942089508;5824.242848429677;5830.650160990354;5837.7664893404635;4716.6698331116495;4768.427788665313;4843.07981483517;5314.8937021260135;5325.307709997675;4321.481422229353;4349.804258808361;4370.781460926941;4372.322290045048;4495.348174514677;1387.8064864216765;1406.3530775843021;1409.3516982188103;1422.4168091082606;1432.44134787433;1017.2319898476603;1024.144839059379;1024.5952848624752;1035.006393861901;1042.468341146021;6260.021679296261;6514.088027676129;6521.184851893513;6579.80260592183;6754.3921047106;923.7136487688704;984.2372161574693;1003.4330603209163;1032.3547782635853;1069.112636511709;4306.418633484503;4314.09404025152;4346.587074227943;4370.082282720664;4513.480949690827;12272.815907761391;12605.36973151357;12614;12684.619461416172;12686;11424.714382140513;12272.140950133406;12478.126531142914;12479.625611231677;12505.499780008699;8737.169968852948;9109.180173784258;9196.63213471467;9197.310201734897;9219.262459003397;6308.779192728416;6377.202849643794;6493.155889734304;6523.7716679915975;6632.071509988702;11178.608748693756;11464.885351146715;11479.196456248317;11562.710932226762;11649.650510484698;11667.6499705009;11733.589324373606;11750;11795.587154449897;11816;8401.495910245405;8542.18849209324;8673.089325620971;8774.912250877665;8776.078511756428;9570.330076894828;9653.420794752337;9657.951710241405;9658.3722058066;9692.757681057748;8418.789530261793;8478.83042339162;8577.442466239674;8607.612657430305;8714.477131372138;8165.591720413837;8203.384746143944;8259.876101858597;8261.215184557457;8575.87136192945;7664.463487555818;7783.766487005399;7784.610769461618;7789.805254868674;7846.411519135973;5293.788248470172;5358.196270559291;5489.505944465017;5494.066008778437;5593.412691667317;5303.867403314948;5398.622096453368;5468.343798744176;5505.917411238915;5582.692951887523 10:54:30 INFO - PROCESS | 31932 | |4;prototype.html;329.18526646549776;337.60837428582846;340.9897703068907;341.332694582092;343.1678180412499;5544.86137846554;5623.313006098175;5640.520555752756;5651.067573850315;5666.405027472108;5247.006137667681;5347.278117454142;5367.845913128686;5377.865553361168;5554.222408862753;4171.249175148472;4279.550647182048;4337.893837071542;4370.431843860294;4413.278821259712;4327.567243275663;4364.629006534448;4385.122975404915;4392.516823149451;4398.208322501949;4066.4916885389325;4269.210196113713;4288.807003684841;4308.741475511463;4339.2406328892475;4239.554846741109;4244.978775106136;4264.829406823724;4267.594578515036;4296.849610263642;3743.5320584926885;3746.8875933722034;3753.680937120348;3759.248150369937;3759.9436008459893;5304.867378315535;5364.946350536484;5367.543758780508;5369.838904832822;5420.728963551846;4881.316615673809;4894.989581407409;4907.214845624719;4926.088673595396;4971;5763.394843541451;5789.218455508537;5805.651660900317;5814.226660868433;5841.56188285876;4088.97775556111;4143.482064741907;4161.375793630949;4177.352510360899;4182.351735481006;5950.523958083386;5950.97024514879;5981.1028345748055;5987.550933679991;5996.400359964013;4160.814167962117;4205.936910946339;4208.747475151501;4217.797927590622;4230.386593943861;4115.279826030433;4206.348016057516;4232.894177645583;4236.343366778093;4240.681948853849;4844.224924012141;4858.708477491362;4869.488703686133;4871.683340582851;4890.413150421901;5846.269216347957;5848.210491583582;5872.1813529505225;5919.342584076466;5926.644401335933;1436.346462359624;1468.8384277729442;1468.8824894008453;1470.8087948566617;1475.5278310940396;933.5938866592918;933.9813203735887;952.7094236257869;953.3755390219418;957.1863915671623;5029.396472423333;5073.467285934998;5080.872978175576;5169.043726910533;5207.531322181022;5305.832716802297;5314.973425132927;5319.281896943863;5320.76056577455;5372.059889519319;4726.133177394979;5022.447530771612;5045.747712614355;5053.393592768891;5125.538701516882;2847.6725176604955;2858.3282928511785;2859.7569206617673;2871.5118429866975;2893.942121157565;5453.481919217668;5472.863178420572;5513.696746678971;5516.545137413893;5583.664980101207;5202.661826981234;5216.1832610389965;5388.868337649059;5418.539424148913;5458.372287186945;5437.32033495813;5480.616356855062;5503.367112782002;5512.188783720251;5566.749496272597;5085.364329458817;5303.231031500488;5324.307839980777;5420.322459692538;5434.347878254634;5203.8178663746585;5304.787808487617;5338.4394638563945;5339.252504649275;5346.010987967238;5393.489822849609;5523.2819733436;5559.360673522597;5561.805336813192;5608.672400953558;3870.954842192536;3875.391712439306;3977.482927219443;4068.8372465101065;4182.059036716714;5917.970410147922;5958.314793798769;5967.671778052075;5967.940320596912;5979.611325263844;5773.3072031356505;5857.47282744555;5882.764619429968;5893.351731309638;5906.645601263938;5592.2170896075395;5869.383714709894;5886.94113058864;5891.705414729161;5893.024022868424;5756.971215144065;5794.8989691958395;5797.927383434078;5873.119032145041;5904.586678932434;5700.401457847032;5922.911156332744;5927.8221653350465;5940.495057919952;5946.643201407929;5707.971460142673;5727.427257274239;5767.134929760569;5814.447627475383;5826.89289035099 10:54:30 INFO - PROCESS | 31932 | |5;yui.html;782.3936449251829;801.9518828870268;814.4624547798454;834.3950635789053;897.4166791585473;15248;16337.75493367599;16569.66860662786;16711.582210444714;16749.66500669986;15546.689066218698;15616.531504054868;15731.134787586678;15735.370585176608;15760.133192674399;702.4696354252533;720.5028530314092;721.7726416178913;725.840315130673;832.2592892325835;845.3659755183612;851.1786126388034;852.2415050604967;852.9360297977677;863.654538184728;905.5789058087988;911.886014248219;913.9314551408638;914.3371055984425;915.8671992561075;907.3920473282916;909.7179874239007;910.0626354854477;910.5310764956052;911.0161026091805;557.6431084106175;650.1061041068531;658.3087757854233;661.4278648968608;665.4210836572213;14167;14190.361433735403;14193.574192774233;14194.574162775134;14238.92880535601;14364.209968451836;14824.703505929821;14860.777088343684;15085.3211605478;15115;13211.867881321159;13252.934251896193;13298.601041968659;13581.320933953262;13587.116837405538;4726.7163970161555;4757.09615173116;4787.4494433139935;4912.778924948386;4914.901701965977;70612;71090.64454677745;74334.62832685855;76494.61752691257;76664;11461.312321260752;11847.112844570778;11941.701457463632;12487.125901187012;12700.555480558136;21679.241226556995;21839.235626752987;22024.229151979605;22033;22046.88976555139;8371.204735550113;8459.238668519863;8545.957270213608;8599.61301741423;8677.783055423539;4954.603631709455;5149.665271757399;5161.690298582022;5172.508611681884;5298.947010529845;3605.963940360615;3743.9438408423894;3744.2324323513612;3745.756525825867;3747.3254814133174;616.9290531588834;617.2284644194757;624.7594676049754;638.2755572425331;650.5641220382355;616.309733098932;626.9279532000239;677.9796606101825;713.5148099292427;744.3226663735974;9961.302708810459;10452.843207351896;10466.738331541772;10474.109700675375;10524.526396312185;598.3298705449924;629.2197674883112;643.9889373683366;644.8903686373328;662.8574856405896;4796.664233503691;4816.470188279286;4871.780769865364;4884.5603895649565;4918.458969513351;110940.445297773;111174.44412777884;112266.43866780614;112713.43643281895;119482;90469.54765226263;92372.53813730889;94376;95691;95885;88886.55556722175;89265;90142;90160.5491972549;90779;9105.954470227607;9217.493037882712;9286.210672092948;9298.860517092384;9319.953400232955;52984;53733.46266537285;54826.17760733512;55895.44104559065;56206.437935621754;75298;78149.60925195337;80193;80264.59867700624;81859;12218.389080546114;12243;12510.812337814757;13759.724805504035;13978.44086236539;14730.410783568537;15112.395504179709;15315.693686125993;15865.682686345977;16460;11998.440592574765;13663.043586948817;13733.519326823913;13754.037217394687;13933.58199254024;14264.71470570562;14396.1774094412;14697.04469209498;14919.179445130621;15411.306491207699;13793.793093103412;13985.860141398864;14142.363593638105;14227.857721422653;15204.315805788545;11364.261323014309;11777.35224562623;11957.940210298893;12005.699857503632;12361.93819030899;11337.659870203906;11506.76986460283;11712.531498739954;11981.801819818296;12273.938630307148 10:54:30 INFO - PROCESS | 31932 | __end_tp_report 10:54:30 INFO - PROCESS | 31932 | __start_cc_report 10:54:30 INFO - PROCESS | 31932 | _x_x_mozilla_cycle_collect,957 10:54:30 INFO - PROCESS | 31932 | __end_cc_report 10:54:30 INFO - PROCESS | 31932 | __startTimestamp1467050070833__endTimestamp 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | ------- Summary: start ------- 10:54:30 INFO - PROCESS | 31932 | Number of tests: 6 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | [#0] dojo.html Cycles:165 Average:5546.78 Median:5748.51 stddev:628.80 (10.9%) stddev-sans-first:605.54 10:54:30 INFO - PROCESS | 31932 | Values: 3300.8 3325.3 3343.8 3348.1 3373.2 5496.6 5576.9 5580.0 5599.8 5607.3 5537.6 5595.8 5597.1 5599.1 5642.6 4977.2 5028.5 5053.9 5079.8 5113.4 4934.6 4976.2 4991.3 5028.4 5107.0 5005.3 5039.0 5059.0 5105.1 5107.5 5078.7 5096.9 5096.9 5104.2 5126.4 4767.4 4917.6 4973.2 4999.3 5047.5 5459.8 5485.2 5486.1 5493.4 5497.5 5950.1 5956.8 5957.9 6024.6 6084.1 6044.3 6089.8 6114.2 6114.4 6120.4 5691.6 5708.0 5724.5 5725.0 5732.3 5956.8 6010.5 6040.2 6083.2 6100.1 5877.2 5934.3 5945.3 5946.7 5948.9 5980.0 5995.4 6019.0 6032.3 6041.1 5756.3 5877.6 5878.3 5930.6 6017.8 5983.0 5983.7 5986.2 5987.4 5996.2 4538.9 4574.5 4581.5 4587.0 4612.6 3978.5 4002.0 4046.6 4057.7 4067.4 5714.3 5722.0 5724.3 5729.9 5757.4 5856.0 5990.3 6012.1 6021.6 6037.3 5530.9 5537.6 5605.8 5680.6 5712.6 5149.0 5155.9 5159.2 5161.6 5191.6 6009.1 6020.6 6117.7 6129.3 6129.9 5932.9 6004.3 6008.2 6008.6 6039.5 6171.5 6205.8 6235.1 6239.3 6246.0 5757.5 5847.6 5890.4 5895.8 5906.5 6004.1 6049.4 6052.4 6053.7 6073.7 5861.3 5900.8 5903.7 5905.4 5908.2 5637.4 5734.6 5786.4 5795.7 5875.8 5735.5 5748.5 5750.8 5754.8 5761.0 5845.9 5879.3 5885.6 5903.6 5904.5 5585.1 5588.9 5625.3 5628.6 5681.0 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | [#1] ext.html Cycles:180 Average:59702.66 Median:190292.94 stddev:118650.97 (62.4%) stddev-sans-first:118900.85 10:54:30 INFO - PROCESS | 31932 | Values: 605.2 639.0 653.3 664.3 666.7 32302.7 45162.3 45523.8 45786.0 45793.3 45718.8 46428.8 46457.0 46463.3 46576.0 8256.5 9062.0 9214.6 10682.0 10980.8 10882.0 11015.6 11017.3 11017.6 11018.0 11037.9 11039.8 11087.7 11091.3 11110.8 8427.2 10874.7 11107.9 11131.1 11441.7 10863.0 10914.8 10921.7 10925.9 10928.1 44208.8 44472.6 44601.3 44602.8 44640.0 3765.2 3793.9 3903.0 3937.2 4124.2 33176.5 33180.0 33755.8 33840.8 33916.0 4493.9 4528.5 4549.6 4594.8 4648.3 376792.0 379845.0 379948.0 380324.0 380917.0 37029.0 38036.0 62154.7 62885.7 62895.9 40262.0 40330.4 40367.0 40450.6 40466.4 16048.9 17268.6 17420.5 17428.8 17432.0 14196.0 14638.3 14679.3 14834.9 14988.9 9123.6 9170.4 9173.9 9225.8 9249.4 3497.8 3517.1 3518.4 3551.9 3569.9 1049.9 1071.0 1097.6 1143.8 1229.7 32917.8 32969.4 33216.5 33382.3 33841.5 1099.8 1114.8 1196.7 1196.9 1206.7 17541.4 17678.5 17867.8 17882.2 17883.0 581352.0 583154.0 586237.0 587527.0 587540.0 61942.4 62435.4 62552.4 62566.0 62651.1 1349.1 1440.0 1450.4 1499.6 1504.0 32705.7 34082.8 34217.3 34300.0 34594.8 50794.7 51315.5 51330.7 51384.0 51460.5 331651.0 334075.0 335665.0 336624.0 336900.0 26723.2 28741.1 29872.6 30194.5 30343.7 45520.0 50565.7 51841.5 51892.7 52398.5 41335.6 43186.8 43260.0 43275.8 43700.8 42858.8 43501.8 43928.6 46732.0 48146.8 43288.8 43862.8 45000.0 45141.3 45155.8 37251.3 38694.6 38706.2 38996.8 39005.0 29025.0 29135.6 29523.7 29650.9 29669.6 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | [#2] jquery.html Cycles:180 Average:28617.52 Median:13060.83 stddev:77921.08 (596.6%) stddev-sans-first:78110.92 10:54:30 INFO - PROCESS | 31932 | Values: 427.9 429.5 434.3 441.2 448.7 18713.5 19782.5 20280.3 20671.4 20818.6 19792.3 20228.4 20252.3 20272.3 20316.1 5678.7 5898.5 5937.9 5941.4 5942.6 5856.3 5869.6 5893.5 5895.7 5903.3 5807.9 5813.7 5822.1 5833.9 5838.7 5746.4 5881.0 5884.0 5884.1 5908.1 5093.5 5160.4 5276.6 5284.4 5285.7 23465.0 23552.5 23737.2 24186.8 24245.9 2384.5 2416.9 2427.5 2687.6 3194.6 14600.3 14620.5 14878.9 14899.7 15043.4 2045.2 2056.3 2106.9 2143.0 2171.1 77012.0 80836.6 81142.6 81318.6 82652.2 10961.7 11171.8 11252.3 11422.4 11560.4 16026.4 16093.8 16158.8 16183.4 16191.2 8586.0 8708.5 8798.7 8835.4 8917.7 8537.7 8607.8 8798.0 8798.7 8953.0 6737.3 6897.5 6953.6 6974.9 7024.4 1862.0 1957.5 2043.8 2086.7 2087.8 921.8 1016.3 1041.8 1063.3 1091.3 19342.2 20101.6 20109.0 20147.2 20201.5 1069.4 1071.6 1130.6 1144.1 1218.8 11234.6 11592.2 11733.8 11833.8 11843.8 458933.0 466143.0 474714.0 479443.0 494672.0 63105.0 63195.7 64752.0 82281.0 84196.0 995.7 1045.7 1073.0 1125.7 1127.0 16794.3 17449.7 17553.0 18313.4 18700.0 42866.4 43207.4 43319.4 43921.0 44354.8 57214.4 57931.7 58215.0 60377.4 61441.7 8796.2 8999.9 9108.5 9119.9 9340.3 13915.5 13998.3 14007.2 14169.4 14501.5 11748.1 12023.2 12297.7 12595.1 12632.6 12013.8 12205.5 12333.1 12409.9 12630.2 12580.7 12583.3 12744.4 12824.9 12828.8 7972.3 8884.4 8956.8 8989.3 9287.7 11982.9 12146.1 12402.6 12443.6 12648.6 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | [#3] mootools.html Cycles:180 Average:6414.94 Median:4433.84 stddev:3773.48 (85.1%) stddev-sans-first:3765.21 10:54:30 INFO - PROCESS | 31932 | Values: 1395.3 1525.2 1555.0 1724.6 1838.8 9221.6 9590.0 9612.4 9953.8 9956.9 9573.4 9809.1 9809.7 9816.7 9840.5 2218.4 2433.7 2449.5 2462.6 2524.8 2536.4 2555.3 2563.7 2568.0 2569.7 2446.2 2447.9 2463.8 2467.6 2469.0 2199.8 2425.6 2484.5 2485.4 2500.7 2376.8 2381.7 2385.1 2435.8 2460.8 9372.3 9421.1 9428.4 9445.1 9461.2 5624.8 5768.5 5781.1 5784.2 5785.8 3508.6 3517.1 3590.9 3710.4 3725.8 1248.9 1268.7 1286.7 1294.8 1320.4 14038.7 14052.3 14058.6 14080.5 14085.2 5038.6 5048.6 5076.8 5089.5 5160.5 11538.1 11638.1 11647.9 11681.4 11682.2 5119.3 5770.0 5824.2 5830.7 5837.8 4716.7 4768.4 4843.1 5314.9 5325.3 4321.5 4349.8 4370.8 4372.3 4495.3 1387.8 1406.4 1409.4 1422.4 1432.4 1017.2 1024.1 1024.6 1035.0 1042.5 6260.0 6514.1 6521.2 6579.8 6754.4 923.7 984.2 1003.4 1032.4 1069.1 4306.4 4314.1 4346.6 4370.1 4513.5 12272.8 12605.4 12614.0 12684.6 12686.0 11424.7 12272.1 12478.1 12479.6 12505.5 8737.2 9109.2 9196.6 9197.3 9219.3 6308.8 6377.2 6493.2 6523.8 6632.1 11178.6 11464.9 11479.2 11562.7 11649.7 11667.6 11733.6 11750.0 11795.6 11816.0 8401.5 8542.2 8673.1 8774.9 8776.1 9570.3 9653.4 9658.0 9658.4 9692.8 8418.8 8478.8 8577.4 8607.6 8714.5 8165.6 8203.4 8259.9 8261.2 8575.9 7664.5 7783.8 7784.6 7789.8 7846.4 5293.8 5358.2 5489.5 5494.1 5593.4 5303.9 5398.6 5468.3 5505.9 5582.7 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | [#4] prototype.html Cycles:180 Average:4722.17 Median:5320.02 stddev:1375.98 (25.9%) stddev-sans-first:1339.75 10:54:30 INFO - PROCESS | 31932 | Values: 329.2 337.6 341.0 341.3 343.2 5544.9 5623.3 5640.5 5651.1 5666.4 5247.0 5347.3 5367.8 5377.9 5554.2 4171.2 4279.6 4337.9 4370.4 4413.3 4327.6 4364.6 4385.1 4392.5 4398.2 4066.5 4269.2 4288.8 4308.7 4339.2 4239.6 4245.0 4264.8 4267.6 4296.8 3743.5 3746.9 3753.7 3759.2 3759.9 5304.9 5364.9 5367.5 5369.8 5420.7 4881.3 4895.0 4907.2 4926.1 4971.0 5763.4 5789.2 5805.7 5814.2 5841.6 4089.0 4143.5 4161.4 4177.4 4182.4 5950.5 5951.0 5981.1 5987.6 5996.4 4160.8 4205.9 4208.7 4217.8 4230.4 4115.3 4206.3 4232.9 4236.3 4240.7 4844.2 4858.7 4869.5 4871.7 4890.4 5846.3 5848.2 5872.2 5919.3 5926.6 1436.3 1468.8 1468.9 1470.8 1475.5 933.6 934.0 952.7 953.4 957.2 5029.4 5073.5 5080.9 5169.0 5207.5 5305.8 5315.0 5319.3 5320.8 5372.1 4726.1 5022.4 5045.7 5053.4 5125.5 2847.7 2858.3 2859.8 2871.5 2893.9 5453.5 5472.9 5513.7 5516.5 5583.7 5202.7 5216.2 5388.9 5418.5 5458.4 5437.3 5480.6 5503.4 5512.2 5566.7 5085.4 5303.2 5324.3 5420.3 5434.3 5203.8 5304.8 5338.4 5339.3 5346.0 5393.5 5523.3 5559.4 5561.8 5608.7 3871.0 3875.4 3977.5 4068.8 4182.1 5918.0 5958.3 5967.7 5967.9 5979.6 5773.3 5857.5 5882.8 5893.4 5906.6 5592.2 5869.4 5886.9 5891.7 5893.0 5757.0 5794.9 5797.9 5873.1 5904.6 5700.4 5922.9 5927.8 5940.5 5946.6 5708.0 5727.4 5767.1 5814.4 5826.9 10:54:30 INFO - PROCESS | 31932 | 10:54:30 INFO - PROCESS | 31932 | [#5] yui.html Cycles:180 Average:21142.36 Median:4898.67 stddev:29776.61 (607.9%) stddev-sans-first:29820.90 10:54:30 INFO - PROCESS | 31932 | Values: 782.4 802.0 814.5 834.4 897.4 15248.0 16337.8 16569.7 16711.6 16749.7 15546.7 15616.5 15731.1 15735.4 15760.1 702.5 720.5 721.8 725.8 832.3 845.4 851.2 852.2 852.9 863.7 905.6 911.9 913.9 914.3 915.9 907.4 909.7 910.1 910.5 911.0 557.6 650.1 658.3 661.4 665.4 14167.0 14190.4 14193.6 14194.6 14238.9 14364.2 14824.7 14860.8 15085.3 15115.0 13211.9 13252.9 13298.6 13581.3 13587.1 4726.7 4757.1 4787.4 4912.8 4914.9 70612.0 71090.6 74334.6 76494.6 76664.0 11461.3 11847.1 11941.7 12487.1 12700.6 21679.2 21839.2 22024.2 22033.0 22046.9 8371.2 8459.2 8546.0 8599.6 8677.8 4954.6 5149.7 5161.7 5172.5 5298.9 3606.0 3743.9 3744.2 3745.8 3747.3 616.9 617.2 624.8 638.3 650.6 616.3 626.9 678.0 713.5 744.3 9961.3 10452.8 10466.7 10474.1 10524.5 598.3 629.2 644.0 644.9 662.9 4796.7 4816.5 4871.8 4884.6 4918.5 110940.4 111174.4 112266.4 112713.4 119482.0 90469.5 92372.5 94376.0 95691.0 95885.0 88886.6 89265.0 90142.0 90160.5 90779.0 9106.0 9217.5 9286.2 9298.9 9320.0 52984.0 53733.5 54826.2 55895.4 56206.4 75298.0 78149.6 80193.0 80264.6 81859.0 12218.4 12243.0 12510.8 13759.7 13978.4 14730.4 15112.4 15315.7 15865.7 16460.0 11998.4 13663.0 13733.5 13754.0 13933.6 14264.7 14396.2 14697.0 14919.2 15411.3 13793.8 13985.9 14142.4 14227.9 15204.3 11364.3 11777.4 11957.9 12005.7 12361.9 11337.7 11506.8 11712.5 11981.8 12273.9 10:54:30 INFO - PROCESS | 31932 | -------- Summary: end -------- 10:54:30 INFO - PROCESS | 31932 | 10:54:31 INFO - TEST-INFO | 31932: exit 0 10:54:31 INFO - TEST-OK | dromaeo_css | took 1113951ms 10:54:31 INFO - TEST-START | kraken 10:54:31 INFO - operating with platform_type : linux_ 10:54:31 INFO - Initialising browser for kraken test... 10:54:31 INFO - TEST-INFO | started process 32123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA2iLJn/profile http://localhost:46756/getInfo.html) 10:54:35 INFO - PROCESS | 32123 | __metrics Screen width/height:1600/1200 10:54:35 INFO - PROCESS | 32123 | colorDepth:24 10:54:35 INFO - PROCESS | 32123 | Browser inner width/height: 1024/697 10:54:35 INFO - PROCESS | 32123 | __metrics 10:54:37 ERROR - PROCESS | 32123 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:54:37 INFO - PROCESS | 32123 | console.error: PushService: 10:54:37 INFO - PROCESS | 32123 | stateChangeProcessEnqueue: Error transitioning state 10:54:37 INFO - PROCESS | 32123 | UnknownError 10:54:38 INFO - TEST-INFO | 32123: exit 0 10:54:38 INFO - Browser initialized. 10:54:38 INFO - Running cycle 1/1 for kraken test... 10:54:38 INFO - TEST-INFO | started process 32217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA2iLJn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:49 INFO - PROCESS | 32217 | RSS: Main: 149479424 10:54:49 INFO - PROCESS | 32217 | 10:54:52 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46756/tests/kraken/driver.html?testName=audio-beat-detection) 10:54:53 INFO - PROCESS | 32217 | RSS: Main: 198549504 10:54:53 INFO - PROCESS | 32217 | 10:54:55 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46756/tests/kraken/driver.html?testName=audio-dft) 10:54:56 INFO - PROCESS | 32217 | RSS: Main: 198062080 10:54:56 INFO - PROCESS | 32217 | 10:54:59 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46756/tests/kraken/driver.html?testName=audio-fft) 10:54:59 INFO - PROCESS | 32217 | RSS: Main: 284209152 10:54:59 INFO - PROCESS | 32217 | 10:55:01 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46756/tests/kraken/driver.html?testName=audio-oscillator) 10:55:02 INFO - PROCESS | 32217 | RSS: Main: 193159168 10:55:02 INFO - PROCESS | 32217 | 10:55:04 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:55:05 INFO - PROCESS | 32217 | RSS: Main: 193167360 10:55:05 INFO - PROCESS | 32217 | 10:55:08 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46756/tests/kraken/driver.html?testName=imaging-darkroom) 10:55:08 INFO - PROCESS | 32217 | RSS: Main: 228552704 10:55:08 INFO - PROCESS | 32217 | 10:55:12 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46756/tests/kraken/driver.html?testName=imaging-desaturate) 10:55:12 INFO - PROCESS | 32217 | RSS: Main: 227414016 10:55:12 INFO - PROCESS | 32217 | 10:55:15 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46756/tests/kraken/driver.html?testName=json-parse-financial) 10:55:16 INFO - PROCESS | 32217 | RSS: Main: 227340288 10:55:16 INFO - PROCESS | 32217 | 10:55:17 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:55:18 INFO - PROCESS | 32217 | RSS: Main: 204947456 10:55:18 INFO - PROCESS | 32217 | 10:55:19 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:20 INFO - PROCESS | 32217 | RSS: Main: 205516800 10:55:20 INFO - PROCESS | 32217 | 10:55:22 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:55:23 INFO - PROCESS | 32217 | RSS: Main: 210579456 10:55:23 INFO - PROCESS | 32217 | 10:55:25 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:55:26 INFO - PROCESS | 32217 | RSS: Main: 215281664 10:55:26 INFO - PROCESS | 32217 | 10:55:28 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:55:29 INFO - PROCESS | 32217 | RSS: Main: 217759744 10:55:29 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | Cycle 1(1): loaded http://localhost:46756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46756/tests/kraken/driver.html?testName=ai-astar) 10:55:31 INFO - PROCESS | 32217 | RSS: Main: 259510272 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | __start_tp_report 10:55:31 INFO - PROCESS | 32217 | _x_x_mozilla_page_load 10:55:31 INFO - PROCESS | 32217 | _x_x_mozilla_page_load_details 10:55:31 INFO - PROCESS | 32217 | |i|pagename|runs| 10:55:31 INFO - PROCESS | 32217 | |0;ai-astar;113;104;109;112;111;111;111;111;113;111 10:55:31 INFO - PROCESS | 32217 | |1;audio-beat-detection;148;131;127;176;124;130;154;126;151;123 10:55:31 INFO - PROCESS | 32217 | |2;audio-dft;161;160;162;160;161;160;160;160;161;160 10:55:31 INFO - PROCESS | 32217 | |3;audio-fft;76;76;75;119;76;77;75;76;99;75 10:55:31 INFO - PROCESS | 32217 | |4;audio-oscillator;84;86;114;84;84;85;110;84;84;120 10:55:31 INFO - PROCESS | 32217 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;116;117;116 10:55:31 INFO - PROCESS | 32217 | |6;imaging-darkroom;145;146;146;146;146;145;145;145;146;145 10:55:31 INFO - PROCESS | 32217 | |7;imaging-desaturate;98;95;95;95;95;95;95;94;94;94 10:55:31 INFO - PROCESS | 32217 | |8;json-parse-financial;50;52;49;51;55;52;50;52;53;52 10:55:31 INFO - PROCESS | 32217 | |9;json-stringify-tinderbox;60;60;59;60;61;60;62;60;62;60 10:55:31 INFO - PROCESS | 32217 | |10;stanford-crypto-aes;76;81;77;77;76;77;79;81;125;75 10:55:31 INFO - PROCESS | 32217 | |11;stanford-crypto-ccm;117;125;128;124;124;116;115;117;128;126 10:55:31 INFO - PROCESS | 32217 | |12;stanford-crypto-pbkdf2;153;152;152;157;152;155;152;152;150;151 10:55:31 INFO - PROCESS | 32217 | |13;stanford-crypto-sha256-iterative;62;62;62;64;63;61;60;59;61;59 10:55:31 INFO - PROCESS | 32217 | __end_tp_report 10:55:31 INFO - PROCESS | 32217 | __start_cc_report 10:55:31 INFO - PROCESS | 32217 | _x_x_mozilla_cycle_collect,1588 10:55:31 INFO - PROCESS | 32217 | __end_cc_report 10:55:31 INFO - PROCESS | 32217 | __startTimestamp1467050131408__endTimestamp 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | ------- Summary: start ------- 10:55:31 INFO - PROCESS | 32217 | Number of tests: 14 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.59 (2.3%) stddev-sans-first:2.60 10:55:31 INFO - PROCESS | 32217 | Values: 113.0 104.0 109.0 112.0 111.0 111.0 111.0 111.0 113.0 111.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:139.50 stddev:17.51 (12.5%) stddev-sans-first:18.26 10:55:31 INFO - PROCESS | 32217 | Values: 148.0 131.0 127.0 176.0 124.0 130.0 154.0 126.0 151.0 123.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 10:55:31 INFO - PROCESS | 32217 | Values: 161.0 160.0 162.0 160.0 161.0 160.0 160.0 160.0 161.0 160.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.80 (19.5%) stddev-sans-first:15.52 10:55:31 INFO - PROCESS | 32217 | Values: 76.0 76.0 75.0 119.0 76.0 77.0 75.0 76.0 99.0 75.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:14.81 (17.6%) stddev-sans-first:15.31 10:55:31 INFO - PROCESS | 32217 | Values: 84.0 86.0 114.0 84.0 84.0 85.0 110.0 84.0 84.0 120.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:55:31 INFO - PROCESS | 32217 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:55:31 INFO - PROCESS | 32217 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.15 (1.2%) stddev-sans-first:0.50 10:55:31 INFO - PROCESS | 32217 | Values: 98.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.71 (3.3%) stddev-sans-first:1.72 10:55:31 INFO - PROCESS | 32217 | Values: 50.0 52.0 49.0 51.0 55.0 52.0 50.0 52.0 53.0 52.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 10:55:31 INFO - PROCESS | 32217 | Values: 60.0 60.0 59.0 60.0 61.0 60.0 62.0 60.0 62.0 60.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:77.00 stddev:15.11 (19.6%) stddev-sans-first:15.85 10:55:31 INFO - PROCESS | 32217 | Values: 76.0 81.0 77.0 77.0 76.0 77.0 79.0 81.0 125.0 75.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:124.50 stddev:5.16 (4.1%) stddev-sans-first:5.15 10:55:31 INFO - PROCESS | 32217 | Values: 117.0 125.0 128.0 124.0 124.0 116.0 115.0 117.0 128.0 126.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:152.00 stddev:2.01 (1.3%) stddev-sans-first:2.13 10:55:31 INFO - PROCESS | 32217 | Values: 153.0 152.0 152.0 157.0 152.0 155.0 152.0 152.0 150.0 151.0 10:55:31 INFO - PROCESS | 32217 | 10:55:31 INFO - PROCESS | 32217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:62.00 stddev:1.64 (2.6%) stddev-sans-first:1.72 10:55:31 INFO - PROCESS | 32217 | Values: 62.0 62.0 62.0 64.0 63.0 61.0 60.0 59.0 61.0 59.0 10:55:31 INFO - PROCESS | 32217 | -------- Summary: end -------- 10:55:31 INFO - PROCESS | 32217 | 10:55:32 INFO - TEST-INFO | 32217: exit 0 10:55:32 INFO - TEST-OK | kraken | took 60834ms 10:55:32 INFO - SUITE-END | took 1174s 10:55:32 INFO - Completed test suite (00:19:35) 10:55:32 INFO - javascript benchmark 10:55:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.785448945818, 3325.2850637113015, 3343.7993720376785, 3348.112750121217, 3373.1567108222944, 5496.615236933416, 5576.944230557693, 5579.995600791855, 5599.832005039845, 5607.299087614043, 5537.612367134302, 5595.804146854861, 5597.104463285875, 5599.132134519145, 5642.633228840123, 4977.228529577903, 5028.472010438906, 5053.873653158664, 5079.822206222783, 5113.386393632769, 4934.555889969902, 4976.2286845539, 4991.301217829507, 5028.446870844205, 5107.029664363778, 5005.274235235888, 5039.042581909425, 5059.0, 5105.05556472052, 5107.489251074881, 5078.695278283278, 5096.923546146811, 5096.949030509684, 5104.2088476286235, 5126.41046279677, 4767.356406885061, 4917.582005529534, 4973.15456372414, 4999.325091112726, 5047.520485553867, 5459.781608735686, 5485.177223416479, 5486.067368547357, 5493.423190564973, 5497.505224529811, 5950.077737950624, 5956.761729530814, 5957.880842383128, 6024.608400453956, 6084.148219249309, 6044.335123136451, 6089.77242061708, 6114.205153330083, 6114.449699527064, 6120.357362476965, 5691.601587888849, 5708.0, 5724.513416359573, 5725.0, 5732.340780810218, 5956.761729530857, 6010.4891084258325, 6040.244969378828, 6083.178770865877, 6100.084987251859, 5877.206577112121, 5934.258217722785, 5945.346011938684, 5946.732397042144, 5948.940510594839, 5980.043193089172, 5995.400459953969, 6019.0, 6032.276126864805, 6041.124037014608, 5756.309242890796, 5877.559183061202, 5878.323992740804, 5930.644161350333, 6017.819465416044, 5982.952983228005, 5983.730732117066, 5986.161937328778, 5987.401259874065, 5996.190514280516, 4538.909221815546, 4574.519675434098, 4581.541845815392, 4587.036722288357, 4612.561806628365, 3978.4629075074495, 4001.979990100031, 4046.635802777764, 4057.69567282455, 4067.389891516237, 5714.257146570919, 5721.971390143106, 5724.313082430135, 5729.914051289151, 5757.424257574209, 5855.970720146372, 5990.341062483123, 6012.068129439944, 6021.57848950578, 6037.275526936708, 5530.889382212334, 5537.58468114893, 5605.8037968671715, 5680.602357834912, 5712.6286791358425, 5148.974255128775, 5155.896882062338, 5159.174532074925, 5161.561267292247, 5191.584673226208, 6009.128676341906, 6020.638761674313, 6117.724702388403, 6129.325774164839, 6129.877402451926, 5932.851678707894, 6004.339522652417, 6008.158857760004, 6008.639481630941, 6039.456448919618, 6171.506279497539, 6205.81382558524, 6235.064740288993, 6239.282482514387, 6246.0, 5757.453041961007, 5847.619904706181, 5890.352061273342, 5895.793647222326, 5906.497947674324, 6004.0693692477735, 6049.425304596057, 6052.425019623129, 6053.727582258897, 6073.665948372882, 5861.296644402699, 5900.763969441175, 5903.7048147593305, 5905.35041145465, 5908.172855800105, 5637.379888212211, 5734.569907256889, 5786.42135786418, 5795.739191736467, 5875.794347197999, 5735.483806457272, 5748.511376533042, 5750.7987220447085, 5754.798582049608, 5760.971195143998, 5845.883082338414, 5879.2944846618675, 5885.5880088395115, 5903.586748927705, 5904.468597826216, 5585.050541408052, 5588.888222235614, 5625.296837895263, 5628.634138780966, 5681.0], "value": 5505.022423337225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.1588292273738, 639.0, 653.3172834388064, 664.2560332427681, 666.6633350158171, 32302.67697323026, 45162.32256516151, 45523.77238113813, 45786.0, 45793.31310030352, 45718.77140614301, 46428.76785616067, 46457.0, 46463.30305045418, 46576.0, 8256.504609723406, 9061.999999999984, 9214.585343659552, 10682.0, 10980.835287470694, 10882.0, 11015.614453494129, 11017.28387654804, 11017.614383496579, 11018.0, 11037.944810275938, 11039.83440248397, 11087.667369978913, 11091.279066860669, 11110.777784444306, 8427.241548260656, 10874.728131796728, 11107.944460277728, 11131.109511239081, 11441.656750297505, 10863.0, 10914.781704365947, 10921.672349829518, 10925.890741092568, 10928.125749939985, 44208.778956105016, 44472.555274447164, 44601.33098003532, 44602.77698611486, 44640.0, 3765.228128233733, 3793.8861834144745, 3902.9804850975847, 3937.153511994935, 4124.237016152021, 33176.50235246473, 33180.0, 33755.83122084398, 33840.83079584611, 33916.0, 4493.932591011137, 4528.479224889147, 4549.590536851666, 4594.816207351702, 4648.349231107613, 376792.0, 379845.0, 379947.99999999726, 380324.0, 380917.0, 37029.0, 38036.0, 62154.68922655358, 62885.68557157185, 62895.85520724037, 40262.0, 40330.395044074365, 40367.0, 40450.59549404468, 40466.39300410496, 16048.919755401148, 17268.568285792706, 17420.47738567845, 17428.825711742975, 17432.0, 14196.0, 14638.268086595628, 14679.339429725687, 14834.925825370805, 14988.850111498963, 9123.589438475285, 9170.368963673436, 9173.908260917438, 9225.769355766026, 9249.445033298023, 3497.8076205808925, 3517.120719820045, 3518.3842827505086, 3551.9289614207573, 3569.8750543730844, 1049.9055085042382, 1071.0467683761458, 1097.5609756097465, 1143.8341440491083, 1229.655696405008, 32917.835410822794, 32969.38450513572, 33216.501752473734, 33382.332353352795, 33841.474022197755, 1099.8185299425504, 1114.7603265298, 1196.7187710887933, 1196.904247660185, 1206.6741979665442, 17541.386051488138, 17678.46964591064, 17867.821321786614, 17882.195301211475, 17883.0, 581352.0, 583154.0, 586237.0, 587527.0, 587540.0, 61942.38057619456, 62435.37564624386, 62552.374476254656, 62566.0, 62651.06023409653, 1349.1432940083118, 1439.9568012959628, 1450.3835869755312, 1499.6250937265684, 1503.9924800375927, 32705.672943270263, 34082.82958585191, 34217.315653687285, 34300.0, 34594.827025865714, 50794.74602626963, 51315.48684513107, 51330.74334628303, 51384.0, 51460.485395145566, 331651.0, 334075.0, 335665.0, 336624.0, 336900.0, 26723.19830405091, 28741.137765867057, 29872.551911720908, 30194.54708179423, 30343.696563034086, 45520.0, 50565.74717126391, 51841.481585185174, 51892.740536297075, 52398.47601523936, 41335.586644133175, 43186.78406607947, 43260.0, 43275.783621082956, 43700.78149609231, 42858.78570607127, 43501.78249108734, 43928.56071439372, 46732.0, 48146.759266203444, 43288.78355608202, 43862.78068609637, 45000.0, 45141.32288015616, 45155.77422113, 37251.254974899806, 38694.61305387023, 38706.206443064155, 38996.805015974736, 39005.0, 29025.03399184223, 29135.562966555095, 29523.704762952097, 29650.851745741995, 29669.554956675234], "value": 20232.141274770624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.8523909251308, 429.50177793759246, 434.34268650823026, 441.20362745244836, 448.699371421148, 18713.532161695963, 19782.505437364074, 20280.29018984336, 20671.379858604265, 20818.583628327462, 19792.30726924558, 20228.39314820554, 20252.29116980906, 20272.29046983356, 20316.085776140073, 5678.659280443177, 5898.469137777599, 5937.851553711149, 5941.376155503674, 5942.6434413935085, 5856.297244330686, 5869.589128760988, 5893.528517718593, 5895.675737834417, 5903.26209223847, 5807.912881306784, 5813.7383817728305, 5822.068469044953, 5833.941660583382, 5838.678872662002, 5746.425357464262, 5881.029630111027, 5884.0, 5884.087966365241, 5908.14331921869, 5093.541581257705, 5160.354955630546, 5276.551493123089, 5284.445133260991, 5285.7357132143625, 23465.0, 23552.52894942109, 23737.16919907795, 24186.758132418803, 24245.87877060621, 2384.499255156419, 2416.903323867043, 2427.4780922101654, 2687.6371689821817, 3194.552762613213, 14600.34298456572, 14620.488282910048, 14878.851211487854, 14899.702005959929, 15043.398264069425, 2045.202371075282, 2056.331692200041, 2106.8630539014916, 2143.046344376753, 2171.0555908179836, 77012.0, 80836.59581702112, 81142.59428702819, 81318.59340703317, 82652.17347826505, 10961.725956850983, 11171.83242251367, 11252.324860508395, 11422.428878556038, 11560.364179970182, 16026.358945642043, 16093.839061609468, 16158.838411615734, 16183.433579824885, 16191.190440477929, 8585.957070214608, 8708.52103134321, 8798.692045778495, 8835.381523293436, 8917.73246802597, 8537.724426609388, 8607.784805379915, 8797.956010219908, 8798.692045778367, 8953.0, 6737.292584278678, 6897.517173797786, 6953.574517223957, 6974.930250697529, 7024.367806897404, 1861.9534511637046, 1957.549763554362, 2043.754749430078, 2086.6525159195903, 2087.7807830177917, 921.7879887625884, 1016.2987538598344, 1041.7916416716535, 1063.3194755356578, 1091.3233795046963, 19342.226310947684, 20101.597968040558, 20109.0, 20147.19411223564, 20201.49496262576, 1069.385103565453, 1071.566015763617, 1130.6268931252666, 1144.1247445704043, 1218.7623413434296, 11234.550617975354, 11592.188546801812, 11733.823992640117, 11833.822492662617, 11843.763124737457, 458933.0, 466143.0, 474714.0, 479443.0, 494672.0, 63105.0, 63195.68402158052, 64752.0, 82281.0, 84196.0, 995.711243739322, 1045.7333379988206, 1072.962446314391, 1125.6904351303458, 1126.9661910142709, 16794.328226871276, 17449.69127315431, 17553.0, 18313.359032434335, 18700.0, 42866.357004644335, 43207.35188972105, 43319.35020974751, 43921.0, 44354.77822610866, 57214.42785572258, 57931.71034144802, 58215.0, 60377.39622603718, 61441.69279153576, 8796.164364385373, 8999.865002025106, 9108.453492790453, 9119.908800911906, 9340.252779777737, 13915.512957046454, 13998.300084995913, 14007.159570425807, 14169.36237869319, 14501.492447764278, 11748.118891083373, 12023.158378913393, 12297.692557686129, 12595.11834171636, 12632.621021369374, 12013.75972480528, 12205.450754716237, 12333.136680432284, 12409.875901241234, 12630.179038362478, 12580.748385032432, 12583.307918064595, 12744.362781861055, 12824.87175128274, 12828.807567886675, 7972.322352600094, 8884.37809353339, 8956.820863582821, 8989.325800565115, 9287.72136835896, 11982.940085299517, 12146.089043321963, 12402.627921162379, 12443.564475243324, 12648.557300494438], "value": 9747.216926623714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.3441882315308, 1525.229758971719, 1554.9766753498695, 1724.551616579689, 1838.8253115953987, 9221.58502867371, 9589.952050239757, 9612.423254604728, 9953.800923981516, 9956.850647240297, 9573.425594464337, 9809.068138526829, 9809.70570882873, 9816.705498835028, 9840.458774767385, 2218.4010317214343, 2433.7444568320293, 2449.546833835746, 2462.6182941644074, 2524.772770450659, 2536.441982763798, 2555.3356127406823, 2563.6923569171727, 2568.036986130201, 2569.704483984338, 2446.156076153733, 2447.877606119687, 2463.8398504097268, 2467.592847180213, 2468.950620987588, 2199.7690242524463, 2425.563398588253, 2484.5403600333816, 2485.42835147917, 2500.72492025877, 2376.7623237676266, 2381.6546600742795, 2385.0579021286667, 2435.780779729833, 2460.8400453970435, 9372.250219982385, 9421.104995025531, 9428.434293942386, 9445.102715242041, 9461.19579835708, 5624.803131890364, 5768.480836724673, 5781.103928891029, 5784.16129661201, 5785.768569257225, 3508.5965114011706, 3517.1383011162175, 3590.856365745367, 3710.3692372296773, 3725.8137093145233, 1248.9000879929583, 1268.6511209417392, 1286.7040580666405, 1294.8057791331282, 1320.3926193950795, 14038.719225615532, 14052.297385130805, 14058.578242652635, 14080.507182248572, 14085.15489070659, 5038.647294689336, 5048.646594738333, 5076.847694569169, 5089.541941225308, 5160.535551800356, 11538.13463990204, 11638.06895448362, 11647.941760291314, 11681.357525336189, 11682.24065435744, 5119.283300337956, 5770.047942089508, 5824.242848429677, 5830.650160990354, 5837.7664893404635, 4716.6698331116495, 4768.427788665313, 4843.07981483517, 5314.8937021260135, 5325.307709997675, 4321.481422229353, 4349.804258808361, 4370.781460926941, 4372.322290045048, 4495.348174514677, 1387.8064864216765, 1406.3530775843021, 1409.3516982188103, 1422.4168091082606, 1432.44134787433, 1017.2319898476603, 1024.144839059379, 1024.5952848624752, 1035.006393861901, 1042.468341146021, 6260.021679296261, 6514.088027676129, 6521.184851893513, 6579.80260592183, 6754.3921047106, 923.7136487688704, 984.2372161574693, 1003.4330603209163, 1032.3547782635853, 1069.112636511709, 4306.418633484503, 4314.09404025152, 4346.587074227943, 4370.082282720664, 4513.480949690827, 12272.815907761391, 12605.36973151357, 12614.0, 12684.619461416172, 12686.0, 11424.714382140513, 12272.140950133406, 12478.126531142914, 12479.625611231677, 12505.499780008699, 8737.169968852948, 9109.180173784258, 9196.63213471467, 9197.310201734897, 9219.262459003397, 6308.779192728416, 6377.202849643794, 6493.155889734304, 6523.7716679915975, 6632.071509988702, 11178.608748693756, 11464.885351146715, 11479.196456248317, 11562.710932226762, 11649.650510484698, 11667.6499705009, 11733.589324373606, 11750.0, 11795.587154449897, 11816.0, 8401.495910245405, 8542.18849209324, 8673.089325620971, 8774.912250877665, 8776.078511756428, 9570.330076894828, 9653.420794752337, 9657.951710241405, 9658.3722058066, 9692.757681057748, 8418.789530261793, 8478.83042339162, 8577.442466239674, 8607.612657430305, 8714.477131372138, 8165.591720413837, 8203.384746143944, 8259.876101858597, 8261.215184557457, 8575.87136192945, 7664.463487555818, 7783.766487005399, 7784.610769461618, 7789.805254868674, 7846.411519135973, 5293.788248470172, 5358.196270559291, 5489.505944465017, 5494.066008778437, 5593.412691667317, 5303.867403314948, 5398.622096453368, 5468.343798744176, 5505.917411238915, 5582.692951887523], "value": 5071.00096541995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.18526646549776, 337.60837428582846, 340.9897703068907, 341.332694582092, 343.1678180412499, 5544.86137846554, 5623.313006098175, 5640.520555752756, 5651.067573850315, 5666.405027472108, 5247.006137667681, 5347.278117454142, 5367.845913128686, 5377.865553361168, 5554.222408862753, 4171.249175148472, 4279.550647182048, 4337.893837071542, 4370.431843860294, 4413.278821259712, 4327.567243275663, 4364.629006534448, 4385.122975404915, 4392.516823149451, 4398.208322501949, 4066.4916885389325, 4269.210196113713, 4288.807003684841, 4308.741475511463, 4339.2406328892475, 4239.554846741109, 4244.978775106136, 4264.829406823724, 4267.594578515036, 4296.849610263642, 3743.5320584926885, 3746.8875933722034, 3753.680937120348, 3759.248150369937, 3759.9436008459893, 5304.867378315535, 5364.946350536484, 5367.543758780508, 5369.838904832822, 5420.728963551846, 4881.316615673809, 4894.989581407409, 4907.214845624719, 4926.088673595396, 4971.0, 5763.394843541451, 5789.218455508537, 5805.651660900317, 5814.226660868433, 5841.56188285876, 4088.97775556111, 4143.482064741907, 4161.375793630949, 4177.352510360899, 4182.351735481006, 5950.523958083386, 5950.97024514879, 5981.1028345748055, 5987.550933679991, 5996.400359964013, 4160.814167962117, 4205.936910946339, 4208.747475151501, 4217.797927590622, 4230.386593943861, 4115.279826030433, 4206.348016057516, 4232.894177645583, 4236.343366778093, 4240.681948853849, 4844.224924012141, 4858.708477491362, 4869.488703686133, 4871.683340582851, 4890.413150421901, 5846.269216347957, 5848.210491583582, 5872.1813529505225, 5919.342584076466, 5926.644401335933, 1436.346462359624, 1468.8384277729442, 1468.8824894008453, 1470.8087948566617, 1475.5278310940396, 933.5938866592918, 933.9813203735887, 952.7094236257869, 953.3755390219418, 957.1863915671623, 5029.396472423333, 5073.467285934998, 5080.872978175576, 5169.043726910533, 5207.531322181022, 5305.832716802297, 5314.973425132927, 5319.281896943863, 5320.76056577455, 5372.059889519319, 4726.133177394979, 5022.447530771612, 5045.747712614355, 5053.393592768891, 5125.538701516882, 2847.6725176604955, 2858.3282928511785, 2859.7569206617673, 2871.5118429866975, 2893.942121157565, 5453.481919217668, 5472.863178420572, 5513.696746678971, 5516.545137413893, 5583.664980101207, 5202.661826981234, 5216.1832610389965, 5388.868337649059, 5418.539424148913, 5458.372287186945, 5437.32033495813, 5480.616356855062, 5503.367112782002, 5512.188783720251, 5566.749496272597, 5085.364329458817, 5303.231031500488, 5324.307839980777, 5420.322459692538, 5434.347878254634, 5203.8178663746585, 5304.787808487617, 5338.4394638563945, 5339.252504649275, 5346.010987967238, 5393.489822849609, 5523.2819733436, 5559.360673522597, 5561.805336813192, 5608.672400953558, 3870.954842192536, 3875.391712439306, 3977.482927219443, 4068.8372465101065, 4182.059036716714, 5917.970410147922, 5958.314793798769, 5967.671778052075, 5967.940320596912, 5979.611325263844, 5773.3072031356505, 5857.47282744555, 5882.764619429968, 5893.351731309638, 5906.645601263938, 5592.2170896075395, 5869.383714709894, 5886.94113058864, 5891.705414729161, 5893.024022868424, 5756.971215144065, 5794.8989691958395, 5797.927383434078, 5873.119032145041, 5904.586678932434, 5700.401457847032, 5922.911156332744, 5927.8221653350465, 5940.495057919952, 5946.643201407929, 5707.971460142673, 5727.427257274239, 5767.134929760569, 5814.447627475383, 5826.89289035099], "value": 4283.393858232898, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.3936449251829, 801.9518828870268, 814.4624547798454, 834.3950635789053, 897.4166791585473, 15248.0, 16337.75493367599, 16569.66860662786, 16711.582210444714, 16749.66500669986, 15546.689066218698, 15616.531504054868, 15731.134787586678, 15735.370585176608, 15760.133192674399, 702.4696354252533, 720.5028530314092, 721.7726416178913, 725.840315130673, 832.2592892325835, 845.3659755183612, 851.1786126388034, 852.2415050604967, 852.9360297977677, 863.654538184728, 905.5789058087988, 911.886014248219, 913.9314551408638, 914.3371055984425, 915.8671992561075, 907.3920473282916, 909.7179874239007, 910.0626354854477, 910.5310764956052, 911.0161026091805, 557.6431084106175, 650.1061041068531, 658.3087757854233, 661.4278648968608, 665.4210836572213, 14167.0, 14190.361433735403, 14193.574192774233, 14194.574162775134, 14238.92880535601, 14364.209968451836, 14824.703505929821, 14860.777088343684, 15085.3211605478, 15115.0, 13211.867881321159, 13252.934251896193, 13298.601041968659, 13581.320933953262, 13587.116837405538, 4726.7163970161555, 4757.09615173116, 4787.4494433139935, 4912.778924948386, 4914.901701965977, 70612.0, 71090.64454677745, 74334.62832685855, 76494.61752691257, 76664.0, 11461.312321260752, 11847.112844570778, 11941.701457463632, 12487.125901187012, 12700.555480558136, 21679.241226556995, 21839.235626752987, 22024.229151979605, 22033.0, 22046.88976555139, 8371.204735550113, 8459.238668519863, 8545.957270213608, 8599.61301741423, 8677.783055423539, 4954.603631709455, 5149.665271757399, 5161.690298582022, 5172.508611681884, 5298.947010529845, 3605.963940360615, 3743.9438408423894, 3744.2324323513612, 3745.756525825867, 3747.3254814133174, 616.9290531588834, 617.2284644194757, 624.7594676049754, 638.2755572425331, 650.5641220382355, 616.309733098932, 626.9279532000239, 677.9796606101825, 713.5148099292427, 744.3226663735974, 9961.302708810459, 10452.843207351896, 10466.738331541772, 10474.109700675375, 10524.526396312185, 598.3298705449924, 629.2197674883112, 643.9889373683366, 644.8903686373328, 662.8574856405896, 4796.664233503691, 4816.470188279286, 4871.780769865364, 4884.5603895649565, 4918.458969513351, 110940.445297773, 111174.44412777884, 112266.43866780614, 112713.43643281895, 119482.0, 90469.54765226263, 92372.53813730889, 94376.0, 95691.0, 95885.0, 88886.55556722175, 89265.0, 90142.0, 90160.5491972549, 90779.0, 9105.954470227607, 9217.493037882712, 9286.210672092948, 9298.860517092384, 9319.953400232955, 52984.0, 53733.46266537285, 54826.17760733512, 55895.44104559065, 56206.437935621754, 75298.0, 78149.60925195337, 80193.0, 80264.59867700624, 81859.0, 12218.389080546114, 12243.0, 12510.812337814757, 13759.724805504035, 13978.44086236539, 14730.410783568537, 15112.395504179709, 15315.693686125993, 15865.682686345977, 16460.0, 11998.440592574765, 13663.043586948817, 13733.519326823913, 13754.037217394687, 13933.58199254024, 14264.71470570562, 14396.1774094412, 14697.04469209498, 14919.179445130621, 15411.306491207699, 13793.793093103412, 13985.860141398864, 14142.363593638105, 14227.857721422653, 15204.315805788545, 11364.261323014309, 11777.35224562623, 11957.940210298893, 12005.699857503632, 12361.93819030899, 11337.659870203906, 11506.76986460283, 11712.531498739954, 11981.801819818296, 12273.938630307148], "value": 7796.246581663694, "unit": "score"}], "name": "dromaeo_css", "value": 7540.760613485367, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 109.0, 112.0, 111.0, 111.0, 111.0, 111.0, 113.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 127.0, 176.0, 124.0, 130.0, 154.0, 126.0, 151.0, 123.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 119.0, 76.0, 77.0, 75.0, 76.0, 99.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 114.0, 84.0, 84.0, 85.0, 110.0, 84.0, 84.0, 120.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 49.0, 51.0, 55.0, 52.0, 50.0, 52.0, 53.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 61.0, 60.0, 62.0, 60.0, 62.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 77.0, 77.0, 76.0, 77.0, 79.0, 81.0, 125.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 125.0, 128.0, 124.0, 124.0, 116.0, 115.0, 117.0, 128.0, 126.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 152.0, 157.0, 152.0, 155.0, 152.0, 152.0, 150.0, 151.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 64.0, 63.0, 61.0, 60.0, 59.0, 61.0, 59.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1473.4, "alertThreshold": 2.0}]} 10:55:32 INFO - Return code: 0 10:55:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:55:32 ERROR - # TBPL SUCCESS # 10:55:32 INFO - Running post-action listener: _resource_record_post_action 10:55:32 INFO - ##### 10:55:32 INFO - ##### Finished run-tests step (success) 10:55:32 INFO - ##### 10:55:32 INFO - Running post-run listener: _resource_record_post_run 10:55:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504172544; Read time: 40; Write time: 1008608 10:55:32 INFO - TinderboxPrint: CPU usage
13.2% 10:55:32 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 10:55:32 INFO - TinderboxPrint: I/O write bytes / time
504,172,544 / 1,008,608 10:55:32 INFO - TinderboxPrint: CPU idle
8,258.1 (86.8%) 10:55:32 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 10:55:32 INFO - TinderboxPrint: Swap in / out
0 / 0 10:55:32 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252829696; Read time: 0; Write time: 627844 10:55:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251342848; Read time: 40; Write time: 380764 10:55:33 INFO - Running post-run listener: _upload_blobber_files 10:55:33 INFO - Blob upload gear active. 10:55:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:55:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:55:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:55:33 INFO - (blobuploader) - INFO - Open directory for files ... 10:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:37 INFO - (blobuploader) - INFO - Done attempting. 10:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:38 INFO - (blobuploader) - INFO - Done attempting. 10:55:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:55:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:39 INFO - (blobuploader) - INFO - Done attempting. 10:55:39 INFO - (blobuploader) - INFO - Iteration through files over. 10:55:39 INFO - Return code: 0 10:55:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:55:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:55:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61ba45ed7b98de785ab1240f83d406abb89da3c912dd9413056a814360e4904a981380ecf858815ee85e9f7acb3d7696eeb3d28f70e96bc911fad7073dd36bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a876fb72384e50c6c0c09a55e8165d0e064769a1e5ea539cd5fe80dacced8135b07d715630f72ef26d8dc28e2c081ea5cf9aa3b655a60fa79aa45db317e208a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eab01158fdfc29b1adff8334010cc1d8def43738074fcaa71f3cb11f951307f9e06ae2499717bf5a399a657ab324c1c80e9da4f9566a38d2f34cd7030968dc4"} 10:55:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:55:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:55:39 INFO - Contents: 10:55:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61ba45ed7b98de785ab1240f83d406abb89da3c912dd9413056a814360e4904a981380ecf858815ee85e9f7acb3d7696eeb3d28f70e96bc911fad7073dd36bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a876fb72384e50c6c0c09a55e8165d0e064769a1e5ea539cd5fe80dacced8135b07d715630f72ef26d8dc28e2c081ea5cf9aa3b655a60fa79aa45db317e208a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eab01158fdfc29b1adff8334010cc1d8def43738074fcaa71f3cb11f951307f9e06ae2499717bf5a399a657ab324c1c80e9da4f9566a38d2f34cd7030968dc4"} 10:55:39 INFO - Running post-run listener: copy_logs_to_upload_dir 10:55:39 INFO - Copying logs to upload dir... 10:55:39 INFO - mkdir: /builds/slave/test/build/upload/logs 10:55:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.330357 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-27 10:55:39.112133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 10:55:39.115692) ========= 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=af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61ba45ed7b98de785ab1240f83d406abb89da3c912dd9413056a814360e4904a981380ecf858815ee85e9f7acb3d7696eeb3d28f70e96bc911fad7073dd36bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a876fb72384e50c6c0c09a55e8165d0e064769a1e5ea539cd5fe80dacced8135b07d715630f72ef26d8dc28e2c081ea5cf9aa3b655a60fa79aa45db317e208a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eab01158fdfc29b1adff8334010cc1d8def43738074fcaa71f3cb11f951307f9e06ae2499717bf5a399a657ab324c1c80e9da4f9566a38d2f34cd7030968dc4"} build_url:https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61ba45ed7b98de785ab1240f83d406abb89da3c912dd9413056a814360e4904a981380ecf858815ee85e9f7acb3d7696eeb3d28f70e96bc911fad7073dd36bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a876fb72384e50c6c0c09a55e8165d0e064769a1e5ea539cd5fe80dacced8135b07d715630f72ef26d8dc28e2c081ea5cf9aa3b655a60fa79aa45db317e208a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eab01158fdfc29b1adff8334010cc1d8def43738074fcaa71f3cb11f951307f9e06ae2499717bf5a399a657ab324c1c80e9da4f9566a38d2f34cd7030968dc4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 10:55:39.142388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:55:39.142774) ========= 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=af724c981e2a0f424dbabf99000001e7-1467048896.141031-45932249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:55:39.225736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 10:55:39.226166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 10:55:39.226521) ========= ========= Total master_lag: 0.17 =========