builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1466600495.88 results: success (0) buildid: 20160622044701 builduid: 1fd30879cc954445a7077b7cf4f8db7b revision: 4e17dca08962df106065f09026954efb7e249639 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:35.885257) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:35.885712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:35.885986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:35.900801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:35.901235) ========= 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=523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 06:01:36-- 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% 220M=0s 2016-06-22 06:01:37 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116162 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.061870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.062292) ========= 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=523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019168 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.169715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.170133) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e17dca08962df106065f09026954efb7e249639 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4e17dca08962df106065f09026954efb7e249639 --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=523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 06:01:37,260 truncating revision to first 12 chars 2016-06-22 06:01:37,260 Setting DEBUG logging. 2016-06-22 06:01:37,260 attempt 1/10 2016-06-22 06:01:37,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e17dca08962?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 06:01:37,617 unpacking tar archive at: mozilla-central-4e17dca08962/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.863161) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.863473) ========= script_repo_revision: 4e17dca08962df106065f09026954efb7e249639 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.863896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.864209) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 06:01:36.873096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-22 06:01:36.873441) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:01:38 INFO - MultiFileLogger online at 20160622 06:01:38 in /builds/slave/test 06:01:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:01:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:01:38 INFO - {'append_to_log': False, 06:01:38 INFO - 'base_work_dir': '/builds/slave/test', 06:01:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:01:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:01:38 INFO - 'branch': 'Firefox-Non-PGO', 06:01:38 INFO - 'buildbot_json_path': 'buildprops.json', 06:01:38 INFO - 'config_files': ('talos/linux_config.py',), 06:01:38 INFO - 'default_actions': ('clobber', 06:01:38 INFO - 'read-buildbot-config', 06:01:38 INFO - 'download-and-extract', 06:01:38 INFO - 'populate-webroot', 06:01:38 INFO - 'create-virtualenv', 06:01:38 INFO - 'install', 06:01:38 INFO - 'run-tests'), 06:01:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:01:38 INFO - 'download_minidump_stackwalk': True, 06:01:38 INFO - 'download_symbols': 'ondemand', 06:01:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:01:38 INFO - 'tooltool.py': '/tools/tooltool.py', 06:01:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:01:38 INFO - '/tools/misc-python/virtualenv.py')}, 06:01:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:01:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:01:38 INFO - 'installer_path': 'installer.exe', 06:01:38 INFO - 'log_level': 'info', 06:01:38 INFO - 'log_name': 'talos', 06:01:38 INFO - 'log_to_console': True, 06:01:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:01:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:01:38 INFO - 'opt_config_files': (), 06:01:38 INFO - 'pip_index': False, 06:01:38 INFO - 'sps_profile': False, 06:01:38 INFO - 'sps_profile_interval': 0, 06:01:38 INFO - 'suite': 'dromaeojs', 06:01:38 INFO - 'system_bits': '32', 06:01:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:01:38 INFO - 'title': 'talos-linux64-ix-065', 06:01:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:01:38 INFO - 'use_talos_json': True, 06:01:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:01:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:01:38 INFO - 'work_dir': 'build'} 06:01:38 INFO - ##### 06:01:38 INFO - ##### Running clobber step. 06:01:38 INFO - ##### 06:01:38 INFO - Running pre-action listener: _resource_record_pre_action 06:01:38 INFO - Running main action method: clobber 06:01:38 INFO - rmtree: /builds/slave/test/build 06:01:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:01:38 INFO - Running post-action listener: _resource_record_post_action 06:01:38 INFO - ##### 06:01:38 INFO - ##### Finished clobber step (success) 06:01:38 INFO - ##### 06:01:38 INFO - ##### 06:01:38 INFO - ##### Running read-buildbot-config step. 06:01:38 INFO - ##### 06:01:38 INFO - Running pre-action listener: _resource_record_pre_action 06:01:38 INFO - Running main action method: read_buildbot_config 06:01:38 INFO - Using buildbot properties: 06:01:38 INFO - { 06:01:38 INFO - "project": "", 06:01:38 INFO - "product": "firefox", 06:01:38 INFO - "script_repo_revision": "production", 06:01:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:01:38 INFO - "repository": "", 06:01:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:01:38 INFO - "buildid": "20160622044701", 06:01:38 INFO - "pgo_build": "False", 06:01:38 INFO - "basedir": "/builds/slave/test", 06:01:38 INFO - "buildnumber": 617, 06:01:38 INFO - "slavename": "talos-linux64-ix-065", 06:01:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:01:38 INFO - "platform": "ubuntu64_hw", 06:01:38 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:01:38 INFO - "branch": "mozilla-central", 06:01:38 INFO - "repo_path": "mozilla-central", 06:01:38 INFO - "revision": "4e17dca08962df106065f09026954efb7e249639", 06:01:38 INFO - "stage_platform": "linux64", 06:01:38 INFO - "builduid": "1fd30879cc954445a7077b7cf4f8db7b", 06:01:38 INFO - "slavebuilddir": "test" 06:01:38 INFO - } 06:01:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:01:38 INFO - Running post-action listener: _resource_record_post_action 06:01:38 INFO - ##### 06:01:38 INFO - ##### Finished read-buildbot-config step (success) 06:01:38 INFO - ##### 06:01:38 INFO - ##### 06:01:38 INFO - ##### Running download-and-extract step. 06:01:38 INFO - ##### 06:01:38 INFO - Running pre-action listener: _resource_record_pre_action 06:01:38 INFO - Running main action method: download_and_extract 06:01:38 INFO - mkdir: /builds/slave/test/build/tests 06:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:38 INFO - https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:01:39 INFO - Downloaded 1361 bytes. 06:01:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:39 INFO - Using the following test package requirements: 06:01:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:01:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:01:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'jsshell-linux-x86_64.zip'], 06:01:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:01:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:01:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:01:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:01:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:01:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:01:39 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')]} 06:01:39 INFO - https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:40 INFO - Downloaded 22703215 bytes. 06:01:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:01:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:01:41 INFO - Return code: 0 06:01:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:41 INFO - https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:43 INFO - Downloaded 22703215 bytes. 06:01:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:01:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:01:44 INFO - Return code: 0 06:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:44 INFO - https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:01:45 INFO - Downloaded 14405384 bytes. 06:01:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:01:46 INFO - Return code: 0 06:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:46 INFO - https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:01:47 INFO - Downloaded 56261639 bytes. 06:01:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:47 INFO - mkdir: /builds/slave/test/properties 06:01:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:01:47 INFO - Writing to file /builds/slave/test/properties/build_url 06:01:47 INFO - Contents: 06:01:47 INFO - build_url:https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:48 INFO - Running post-action listener: _resource_record_post_action 06:01:48 INFO - Running post-action listener: set_extra_try_arguments 06:01:48 INFO - ##### 06:01:48 INFO - ##### Finished download-and-extract step (success) 06:01:48 INFO - ##### 06:01:48 INFO - ##### 06:01:48 INFO - ##### Running populate-webroot step. 06:01:48 INFO - ##### 06:01:48 INFO - Running pre-action listener: _resource_record_pre_action 06:01:48 INFO - Running main action method: populate_webroot 06:01:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:01:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:01:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:01:48 INFO - '--tppagecycles', 06:01:48 INFO - '7'], 06:01:48 INFO - 'tests': ['tsvgm']}}, 06:01:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:01:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:01:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:01:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:01:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['damp', 'tps']}, 06:01:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'tests': ['damp', 'tps']}, 06:01:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['dromaeo_dom']}, 06:01:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:01:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['basic_compositor_video']}, 06:01:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:01:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['a11yr', 06:01:48 INFO - 'ts_paint', 06:01:48 INFO - 'tpaint', 06:01:48 INFO - 'sessionrestore', 06:01:48 INFO - 'sessionrestore_no_auto_restore', 06:01:48 INFO - 'tabpaint']}, 06:01:48 INFO - 'other-e10s': {'tests': ['a11yr', 06:01:48 INFO - 'ts_paint', 06:01:48 INFO - 'tpaint', 06:01:48 INFO - 'sessionrestore', 06:01:48 INFO - 'sessionrestore_no_auto_restore', 06:01:48 INFO - 'tabpaint']}, 06:01:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:01:48 INFO - 'ts_paint', 06:01:48 INFO - 'tpaint', 06:01:48 INFO - 'sessionrestore', 06:01:48 INFO - 'sessionrestore_no_auto_restore', 06:01:48 INFO - 'tabpaint']}, 06:01:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:01:48 INFO - 'ts_paint', 06:01:48 INFO - 'tpaint', 06:01:48 INFO - 'sessionrestore', 06:01:48 INFO - 'sessionrestore_no_auto_restore', 06:01:48 INFO - 'tabpaint']}, 06:01:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['a11yr', 06:01:48 INFO - 'ts_paint', 06:01:48 INFO - 'tpaint', 06:01:48 INFO - 'sessionrestore', 06:01:48 INFO - 'sessionrestore_no_auto_restore', 06:01:48 INFO - 'tabpaint']}, 06:01:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['a11yr', 06:01:48 INFO - 'ts_paint', 06:01:48 INFO - 'tpaint', 06:01:48 INFO - 'sessionrestore', 06:01:48 INFO - 'sessionrestore_no_auto_restore', 06:01:48 INFO - 'tabpaint']}, 06:01:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['tsvgx', 06:01:48 INFO - 'tsvgr_opacity', 06:01:48 INFO - 'tart', 06:01:48 INFO - 'tscrollx', 06:01:48 INFO - 'cart']}, 06:01:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:01:48 INFO - 'tsvgr_opacity', 06:01:48 INFO - 'tart', 06:01:48 INFO - 'tscrollx', 06:01:48 INFO - 'cart']}, 06:01:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'talos_options': ['--disable-e10s'], 06:01:48 INFO - 'tests': ['tp5o']}, 06:01:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'tests': ['tp5o']}, 06:01:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'talos_options': ['--disable-e10s', 06:01:48 INFO - '--xperf_path', 06:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:48 INFO - 'tests': ['tp5n']}, 06:01:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:48 INFO - 'talos_options': ['--xperf_path', 06:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:48 INFO - 'tests': ['tp5n']}}, 06:01:48 INFO - 'talos.zip': {'path': '', 06:01:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:01:48 INFO - Running post-action listener: _resource_record_post_action 06:01:48 INFO - ##### 06:01:48 INFO - ##### Finished populate-webroot step (success) 06:01:48 INFO - ##### 06:01:48 INFO - ##### 06:01:48 INFO - ##### Running create-virtualenv step. 06:01:48 INFO - ##### 06:01:48 INFO - Running pre-action listener: _resource_record_pre_action 06:01:48 INFO - Running main action method: create_virtualenv 06:01:48 INFO - Creating virtualenv /builds/slave/test/build/venv 06:01:48 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 06:01:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:01:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:01:48 INFO - Using real prefix '/usr' 06:01:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:01:48 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:50 INFO - Installing pip.................done. 06:01:50 INFO - Return code: 0 06:01:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:01:50 INFO - Using env: {'DISPLAY': ':0', 06:01:50 INFO - 'HOME': '/home/cltbld', 06:01:50 INFO - 'LANG': 'en_US.UTF-8', 06:01:50 INFO - 'LANGUAGE': 'en_US:en', 06:01:50 INFO - 'LOGNAME': 'cltbld', 06:01:50 INFO - 'MAIL': '/var/mail/cltbld', 06:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:50 INFO - 'MOZ_NO_REMOTE': '1', 06:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:50 INFO - 'NO_EM_RESTART': '1', 06:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:50 INFO - 'PWD': '/builds/slave/test', 06:01:50 INFO - 'SHELL': '/bin/bash', 06:01:50 INFO - 'SHLVL': '1', 06:01:50 INFO - 'TERM': 'linux', 06:01:50 INFO - 'TMOUT': '86400', 06:01:50 INFO - 'USER': 'cltbld', 06:01:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:50 INFO - '_': '/tools/buildbot/bin/python'} 06:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:51 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 06:01:51 INFO - Cleaning up... 06:01:51 INFO - Return code: 0 06:01:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:01:51 INFO - Using env: {'DISPLAY': ':0', 06:01:51 INFO - 'HOME': '/home/cltbld', 06:01:51 INFO - 'LANG': 'en_US.UTF-8', 06:01:51 INFO - 'LANGUAGE': 'en_US:en', 06:01:51 INFO - 'LOGNAME': 'cltbld', 06:01:51 INFO - 'MAIL': '/var/mail/cltbld', 06:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:51 INFO - 'MOZ_NO_REMOTE': '1', 06:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:51 INFO - 'NO_EM_RESTART': '1', 06:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:51 INFO - 'PWD': '/builds/slave/test', 06:01:51 INFO - 'SHELL': '/bin/bash', 06:01:51 INFO - 'SHLVL': '1', 06:01:51 INFO - 'TERM': 'linux', 06:01:51 INFO - 'TMOUT': '86400', 06:01:51 INFO - 'USER': 'cltbld', 06:01:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:51 INFO - '_': '/tools/buildbot/bin/python'} 06:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:51 INFO - Downloading/unpacking psutil>=3.1.1 06:01:51 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 06:01:51 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 06:01:51 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 06:01:51 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 06:01:51 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 06:01:51 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 06:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:53 INFO - Installing collected packages: psutil 06:01:53 INFO - Running setup.py install for psutil 06:01:53 INFO - building 'psutil._psutil_linux' extension 06:01:53 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 06:01:53 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 06:01:53 INFO - building 'psutil._psutil_posix' extension 06:01:53 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 06:01:53 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 06:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:53 INFO - Successfully installed psutil 06:01:53 INFO - Cleaning up... 06:01:53 INFO - Return code: 0 06:01:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:01:53 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')]} 06:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:53 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')]} 06:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:53 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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:01:53 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 06:01:53 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 06:01:53 INFO - Using env: {'DISPLAY': ':0', 06:01:53 INFO - 'HOME': '/home/cltbld', 06:01:53 INFO - 'LANG': 'en_US.UTF-8', 06:01:53 INFO - 'LANGUAGE': 'en_US:en', 06:01:53 INFO - 'LOGNAME': 'cltbld', 06:01:53 INFO - 'MAIL': '/var/mail/cltbld', 06:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:53 INFO - 'MOZ_NO_REMOTE': '1', 06:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:53 INFO - 'NO_EM_RESTART': '1', 06:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:53 INFO - 'PWD': '/builds/slave/test', 06:01:53 INFO - 'SHELL': '/bin/bash', 06:01:53 INFO - 'SHLVL': '1', 06:01:53 INFO - 'TERM': 'linux', 06:01:53 INFO - 'TMOUT': '86400', 06:01:53 INFO - 'USER': 'cltbld', 06:01:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:53 INFO - '_': '/tools/buildbot/bin/python'} 06:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:01:56 INFO - Installing collected packages: mozsystemmonitor 06:01:56 INFO - Running setup.py install for mozsystemmonitor 06:01:56 INFO - Successfully installed mozsystemmonitor 06:01:56 INFO - Cleaning up... 06:01:56 INFO - Return code: 0 06:01:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:56 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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:01:56 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 06:01:56 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 06:01:56 INFO - Using env: {'DISPLAY': ':0', 06:01:56 INFO - 'HOME': '/home/cltbld', 06:01:56 INFO - 'LANG': 'en_US.UTF-8', 06:01:56 INFO - 'LANGUAGE': 'en_US:en', 06:01:56 INFO - 'LOGNAME': 'cltbld', 06:01:56 INFO - 'MAIL': '/var/mail/cltbld', 06:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:56 INFO - 'MOZ_NO_REMOTE': '1', 06:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:56 INFO - 'NO_EM_RESTART': '1', 06:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:56 INFO - 'PWD': '/builds/slave/test', 06:01:56 INFO - 'SHELL': '/bin/bash', 06:01:56 INFO - 'SHLVL': '1', 06:01:56 INFO - 'TERM': 'linux', 06:01:56 INFO - 'TMOUT': '86400', 06:01:56 INFO - 'USER': 'cltbld', 06:01:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:56 INFO - '_': '/tools/buildbot/bin/python'} 06:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:01:56 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 06:01:56 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 06:01:56 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 06:01:56 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 06:01:56 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 06:01:56 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 06:01:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:58 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:58 INFO - warning: no files found matching '*.txt' 06:01:58 INFO - no previously-included directories found matching 'build' 06:01:58 INFO - no previously-included directories found matching 'dist' 06:01:58 INFO - no previously-included directories found matching '.git*' 06:01:58 INFO - Installing collected packages: jsonschema, functools32 06:01:58 INFO - Running setup.py install for functools32 06:01:58 INFO - warning: no files found matching '*.txt' 06:01:58 INFO - no previously-included directories found matching 'build' 06:01:58 INFO - no previously-included directories found matching 'dist' 06:01:58 INFO - no previously-included directories found matching '.git*' 06:01:58 INFO - Successfully installed jsonschema functools32 06:01:58 INFO - Cleaning up... 06:01:58 INFO - Return code: 0 06:01:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:01:58 INFO - Using env: {'DISPLAY': ':0', 06:01:58 INFO - 'HOME': '/home/cltbld', 06:01:58 INFO - 'LANG': 'en_US.UTF-8', 06:01:58 INFO - 'LANGUAGE': 'en_US:en', 06:01:58 INFO - 'LOGNAME': 'cltbld', 06:01:58 INFO - 'MAIL': '/var/mail/cltbld', 06:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:58 INFO - 'MOZ_NO_REMOTE': '1', 06:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:58 INFO - 'NO_EM_RESTART': '1', 06:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:58 INFO - 'PWD': '/builds/slave/test', 06:01:58 INFO - 'SHELL': '/bin/bash', 06:01:58 INFO - 'SHLVL': '1', 06:01:58 INFO - 'TERM': 'linux', 06:01:58 INFO - 'TMOUT': '86400', 06:01:58 INFO - 'USER': 'cltbld', 06:01:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:58 INFO - '_': '/tools/buildbot/bin/python'} 06:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:02:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:02:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:02:01 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 06:02:01 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 06:02:01 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 06:02:01 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 06:02:01 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 06:02:01 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 06:02:01 INFO - Downloading docopt-0.6.1.tar.gz 06:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:02:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:02:01 INFO - Running setup.py install for blobuploader 06:02:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:02:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:02:01 INFO - Running setup.py install for requests 06:02:02 INFO - Running setup.py install for docopt 06:02:02 INFO - Successfully installed blobuploader requests docopt 06:02:02 INFO - Cleaning up... 06:02:02 INFO - Return code: 0 06:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:02 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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:02:02 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 06:02:02 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 06:02:02 INFO - Using env: {'DISPLAY': ':0', 06:02:02 INFO - 'HOME': '/home/cltbld', 06:02:02 INFO - 'LANG': 'en_US.UTF-8', 06:02:02 INFO - 'LANGUAGE': 'en_US:en', 06:02:02 INFO - 'LOGNAME': 'cltbld', 06:02:02 INFO - 'MAIL': '/var/mail/cltbld', 06:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:02 INFO - 'MOZ_NO_REMOTE': '1', 06:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:02 INFO - 'NO_EM_RESTART': '1', 06:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:02 INFO - 'PWD': '/builds/slave/test', 06:02:02 INFO - 'SHELL': '/bin/bash', 06:02:02 INFO - 'SHLVL': '1', 06:02:02 INFO - 'TERM': 'linux', 06:02:02 INFO - 'TMOUT': '86400', 06:02:02 INFO - 'USER': 'cltbld', 06:02:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:02 INFO - '_': '/tools/buildbot/bin/python'} 06:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:02 INFO - Running setup.py (path:/tmp/pip-StGGm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:02 INFO - Running setup.py (path:/tmp/pip-srPMJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:02 INFO - Running setup.py (path:/tmp/pip-XcqOgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:02 INFO - Running setup.py (path:/tmp/pip-MFlLH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:02 INFO - Running setup.py (path:/tmp/pip-trkAyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:02 INFO - Running setup.py (path:/tmp/pip-OS43Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:02 INFO - Running setup.py (path:/tmp/pip-GfqVyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:02 INFO - Running setup.py (path:/tmp/pip-ocHidF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:03 INFO - Running setup.py (path:/tmp/pip-fHy75p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:03 INFO - Running setup.py (path:/tmp/pip-RR50vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:03 INFO - Running setup.py (path:/tmp/pip-F_w_LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:03 INFO - Running setup.py (path:/tmp/pip-UnvUXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:03 INFO - Running setup.py (path:/tmp/pip-GJvMN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:03 INFO - Running setup.py (path:/tmp/pip-k2dRPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:03 INFO - Running setup.py (path:/tmp/pip-_6PTyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:03 INFO - Running setup.py (path:/tmp/pip-ZK7T6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:03 INFO - Running setup.py (path:/tmp/pip-XT6QXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:02:03 INFO - Running setup.py install for manifestparser 06:02:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for mozcrash 06:02:03 INFO - Running setup.py install for mozdebug 06:02:03 INFO - Running setup.py install for mozdevice 06:02:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Running setup.py install for mozfile 06:02:04 INFO - Running setup.py install for mozhttpd 06:02:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Running setup.py install for mozinfo 06:02:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Running setup.py install for mozInstall 06:02:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Running setup.py install for mozleak 06:02:04 INFO - Running setup.py install for mozlog 06:02:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Running setup.py install for moznetwork 06:02:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Running setup.py install for mozprocess 06:02:04 INFO - Running setup.py install for mozprofile 06:02:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:02:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:02:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:02:05 INFO - Running setup.py install for mozrunner 06:02:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:02:05 INFO - Running setup.py install for mozscreenshot 06:02:05 INFO - Running setup.py install for moztest 06:02:05 INFO - Running setup.py install for mozversion 06:02:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:02:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:02:05 INFO - Cleaning up... 06:02:05 INFO - Return code: 0 06:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:05 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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:02:05 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 06:02:05 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 06:02:05 INFO - Using env: {'DISPLAY': ':0', 06:02:05 INFO - 'HOME': '/home/cltbld', 06:02:05 INFO - 'LANG': 'en_US.UTF-8', 06:02:05 INFO - 'LANGUAGE': 'en_US:en', 06:02:05 INFO - 'LOGNAME': 'cltbld', 06:02:05 INFO - 'MAIL': '/var/mail/cltbld', 06:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:05 INFO - 'MOZ_NO_REMOTE': '1', 06:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:05 INFO - 'NO_EM_RESTART': '1', 06:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:05 INFO - 'PWD': '/builds/slave/test', 06:02:05 INFO - 'SHELL': '/bin/bash', 06:02:05 INFO - 'SHLVL': '1', 06:02:05 INFO - 'TERM': 'linux', 06:02:05 INFO - 'TMOUT': '86400', 06:02:05 INFO - 'USER': 'cltbld', 06:02:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:05 INFO - '_': '/tools/buildbot/bin/python'} 06:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:05 INFO - Running setup.py (path:/tmp/pip-GGJU9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:05 INFO - Running setup.py (path:/tmp/pip-s8Ji0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:05 INFO - Running setup.py (path:/tmp/pip-hWq1nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:05 INFO - Running setup.py (path:/tmp/pip-1Ueutf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:06 INFO - Running setup.py (path:/tmp/pip-bLCKWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:06 INFO - Running setup.py (path:/tmp/pip-jcNhVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:06 INFO - Running setup.py (path:/tmp/pip-asvnr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:06 INFO - Running setup.py (path:/tmp/pip-OmbT2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:06 INFO - Running setup.py (path:/tmp/pip-UxIW_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:06 INFO - Running setup.py (path:/tmp/pip-XNVRGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:06 INFO - Running setup.py (path:/tmp/pip-QZoJH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:06 INFO - Running setup.py (path:/tmp/pip-nhftGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:06 INFO - Running setup.py (path:/tmp/pip-bzFCJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:06 INFO - Running setup.py (path:/tmp/pip-BKWFeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:06 INFO - Running setup.py (path:/tmp/pip-MIoHpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:06 INFO - Running setup.py (path:/tmp/pip-9g8NUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:06 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)) 06:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:06 INFO - Running setup.py (path:/tmp/pip-Nquw7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:06 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)) 06:02:06 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)) 06:02:06 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)) 06:02:06 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)) 06:02:06 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)) 06:02:06 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)) 06:02:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:08 INFO - Downloading blessings-1.6.tar.gz 06:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:08 INFO - Installing collected packages: blessings 06:02:08 INFO - Running setup.py install for blessings 06:02:09 INFO - Successfully installed blessings 06:02:09 INFO - Cleaning up... 06:02:09 INFO - Return code: 0 06:02:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:09 INFO - Reading from file tmpfile_stdout 06:02:09 INFO - Current package versions: 06:02:09 INFO - argparse == 1.2.1 06:02:09 INFO - blessings == 1.6 06:02:09 INFO - blobuploader == 1.2.4 06:02:09 INFO - docopt == 0.6.1 06:02:09 INFO - functools32 == 3.2.3-2 06:02:09 INFO - jsonschema == 2.5.1 06:02:09 INFO - manifestparser == 1.1 06:02:09 INFO - mozInstall == 1.12 06:02:09 INFO - mozcrash == 0.17 06:02:09 INFO - mozdebug == 0.1 06:02:09 INFO - mozdevice == 0.48 06:02:09 INFO - mozfile == 1.2 06:02:09 INFO - mozhttpd == 0.7 06:02:09 INFO - mozinfo == 0.9 06:02:09 INFO - mozleak == 0.1 06:02:09 INFO - mozlog == 3.2 06:02:09 INFO - moznetwork == 0.27 06:02:09 INFO - mozprocess == 0.22 06:02:09 INFO - mozprofile == 0.28 06:02:09 INFO - mozrunner == 6.11 06:02:09 INFO - mozscreenshot == 0.1 06:02:09 INFO - mozsystemmonitor == 0.3 06:02:09 INFO - moztest == 0.7 06:02:09 INFO - mozversion == 1.4 06:02:09 INFO - psutil == 3.1.1 06:02:09 INFO - requests == 1.2.3 06:02:09 INFO - wsgiref == 0.1.2 06:02:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:09 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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:02:09 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 06:02:09 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 06:02:09 INFO - Using env: {'DISPLAY': ':0', 06:02:09 INFO - 'HOME': '/home/cltbld', 06:02:09 INFO - 'LANG': 'en_US.UTF-8', 06:02:09 INFO - 'LANGUAGE': 'en_US:en', 06:02:09 INFO - 'LOGNAME': 'cltbld', 06:02:09 INFO - 'MAIL': '/var/mail/cltbld', 06:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:09 INFO - 'MOZ_NO_REMOTE': '1', 06:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:09 INFO - 'NO_EM_RESTART': '1', 06:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:09 INFO - 'PWD': '/builds/slave/test', 06:02:09 INFO - 'SHELL': '/bin/bash', 06:02:09 INFO - 'SHLVL': '1', 06:02:09 INFO - 'TERM': 'linux', 06:02:09 INFO - 'TMOUT': '86400', 06:02:09 INFO - 'USER': 'cltbld', 06:02:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:09 INFO - '_': '/tools/buildbot/bin/python'} 06:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 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)) 06:02:09 INFO - Cleaning up... 06:02:09 INFO - Return code: 0 06:02:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:09 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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:02:09 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 06:02:09 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 06:02:09 INFO - Using env: {'DISPLAY': ':0', 06:02:09 INFO - 'HOME': '/home/cltbld', 06:02:09 INFO - 'LANG': 'en_US.UTF-8', 06:02:09 INFO - 'LANGUAGE': 'en_US:en', 06:02:09 INFO - 'LOGNAME': 'cltbld', 06:02:09 INFO - 'MAIL': '/var/mail/cltbld', 06:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:09 INFO - 'MOZ_NO_REMOTE': '1', 06:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:09 INFO - 'NO_EM_RESTART': '1', 06:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:09 INFO - 'PWD': '/builds/slave/test', 06:02:09 INFO - 'SHELL': '/bin/bash', 06:02:09 INFO - 'SHLVL': '1', 06:02:09 INFO - 'TERM': 'linux', 06:02:09 INFO - 'TMOUT': '86400', 06:02:09 INFO - 'USER': 'cltbld', 06:02:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:09 INFO - '_': '/tools/buildbot/bin/python'} 06:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:02:09 INFO - Cleaning up... 06:02:09 INFO - Return code: 0 06:02:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:09 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 0x7ff9e749af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, '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': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', '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 06:02:09 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 06:02:09 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 06:02:09 INFO - Using env: {'DISPLAY': ':0', 06:02:09 INFO - 'HOME': '/home/cltbld', 06:02:09 INFO - 'LANG': 'en_US.UTF-8', 06:02:09 INFO - 'LANGUAGE': 'en_US:en', 06:02:09 INFO - 'LOGNAME': 'cltbld', 06:02:09 INFO - 'MAIL': '/var/mail/cltbld', 06:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:09 INFO - 'MOZ_NO_REMOTE': '1', 06:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:09 INFO - 'NO_EM_RESTART': '1', 06:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:09 INFO - 'PWD': '/builds/slave/test', 06:02:09 INFO - 'SHELL': '/bin/bash', 06:02:09 INFO - 'SHLVL': '1', 06:02:09 INFO - 'TERM': 'linux', 06:02:09 INFO - 'TMOUT': '86400', 06:02:09 INFO - 'USER': 'cltbld', 06:02:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:09 INFO - '_': '/tools/buildbot/bin/python'} 06:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:10 INFO - Downloading/unpacking flake8 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:02:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:02:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:12 INFO - no previously-included directories found matching 'docs/_build' 06:02:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:02:12 INFO - Running setup.py install for pep8 06:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:12 INFO - no previously-included directories found matching 'docs/_build' 06:02:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:02:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:02:12 INFO - Cleaning up... 06:02:12 INFO - Return code: 0 06:02:12 INFO - Running post-action listener: _resource_record_post_action 06:02:12 INFO - Running post-action listener: _start_resource_monitoring 06:02:12 INFO - Starting resource monitoring. 06:02:12 INFO - ##### 06:02:12 INFO - ##### Finished create-virtualenv step (success) 06:02:12 INFO - ##### 06:02:12 INFO - ##### 06:02:12 INFO - ##### Running install step. 06:02:12 INFO - ##### 06:02:12 INFO - Running pre-action listener: _resource_record_pre_action 06:02:12 INFO - Running main action method: install 06:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:13 INFO - Reading from file tmpfile_stdout 06:02:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:02:13 INFO - Reading from file tmpfile_stdout 06:02:13 INFO - Output received: 06:02:13 INFO - Usage: mozinstall [options] installer 06:02:13 INFO - Options: 06:02:13 INFO - -h, --help show this help message and exit 06:02:13 INFO - -d DEST, --destination=DEST 06:02:13 INFO - Directory to install application into. [default: 06:02:13 INFO - "/builds/slave/test"] 06:02:13 INFO - --app=APP Application being installed. [default: firefox] 06:02:13 INFO - mkdir: /builds/slave/test/build/application 06:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:02:29 INFO - Reading from file tmpfile_stdout 06:02:29 INFO - Output received: 06:02:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:02:29 INFO - Running post-action listener: _resource_record_post_action 06:02:29 INFO - ##### 06:02:29 INFO - ##### Finished install step (success) 06:02:29 INFO - ##### 06:02:29 INFO - ##### 06:02:29 INFO - ##### Running run-tests step. 06:02:29 INFO - ##### 06:02:29 INFO - Running pre-action listener: _resource_record_pre_action 06:02:29 INFO - Running main action method: run_tests 06:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:02:29 INFO - Python 2.7.3 06:02:29 INFO - Return code: 0 06:02:29 INFO - grabbing minidump binary from tooltool 06:02: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')]} 06:02:29 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 0x2a551c0>, '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 0x2a560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a56550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:02:29 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 06:02:29 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 06:02:29 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 06:02:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:29 INFO - Return code: 0 06:02:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:02:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:02:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:02:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:02:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:02:30 INFO - Return code: 0 06:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 06:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 06:02:30 INFO - Using env: {'DISPLAY': ':0', 06:02:30 INFO - 'HOME': '/home/cltbld', 06:02:30 INFO - 'LANG': 'en_US.UTF-8', 06:02:30 INFO - 'LANGUAGE': 'en_US:en', 06:02:30 INFO - 'LOGNAME': 'cltbld', 06:02:30 INFO - 'MAIL': '/var/mail/cltbld', 06:02:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:30 INFO - 'MOZ_NO_REMOTE': '1', 06:02:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:30 INFO - 'NO_EM_RESTART': '1', 06:02:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:30 INFO - 'PWD': '/builds/slave/test', 06:02:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:30 INFO - 'SHELL': '/bin/bash', 06:02:30 INFO - 'SHLVL': '1', 06:02:30 INFO - 'TERM': 'linux', 06:02:30 INFO - 'TMOUT': '86400', 06:02:30 INFO - 'USER': 'cltbld', 06:02:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524', 06:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:30 INFO - '_': '/tools/buildbot/bin/python'} 06:02:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 06:02:30 INFO - mozversion application_buildid: 20160622044701 06:02:30 INFO - mozversion application_changeset: 4e17dca08962df106065f09026954efb7e249639 06:02:30 INFO - mozversion application_display_name: Nightly 06:02:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:30 INFO - mozversion application_name: Firefox 06:02:30 INFO - mozversion application_remotingname: firefox 06:02:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:02:30 INFO - mozversion application_vendor: Mozilla 06:02:30 INFO - mozversion application_version: 50.0a1 06:02:30 INFO - mozversion platform_buildid: 20160622044701 06:02:30 INFO - mozversion platform_changeset: 4e17dca08962df106065f09026954efb7e249639 06:02:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:02:30 INFO - mozversion platform_version: 50.0a1 06:02:30 INFO - using testdate: 1466600550 06:02:30 INFO - actual date: 1466600550 06:02:30 INFO - starting webserver on 'localhost:54909' 06:02:30 INFO - SUITE-START | Running 2 tests 06:02:30 INFO - TEST-START | dromaeo_css 06:02:30 INFO - operating with platform_type : linux_ 06:02:30 INFO - Initialising browser for dromaeo_css test... 06:02:30 INFO - TEST-INFO | started process 20478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ_d7C8/profile http://localhost:54909/getInfo.html) 06:02:34 INFO - PROCESS | 20478 | __metrics Screen width/height:1600/1200 06:02:34 INFO - PROCESS | 20478 | colorDepth:24 06:02:34 INFO - PROCESS | 20478 | Browser inner width/height: 1024/697 06:02:34 INFO - PROCESS | 20478 | __metrics 06:02:35 INFO - PROCESS | 20478 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:02:36 INFO - PROCESS | 20478 | console.error: PushService: 06:02:36 INFO - PROCESS | 20478 | stateChangeProcessEnqueue: Error transitioning state 06:02:36 INFO - PROCESS | 20478 | UnknownError 06:02:36 INFO - TEST-INFO | 20478: exit 0 06:02:36 INFO - Browser initialized. 06:02:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:36 INFO - TEST-INFO | started process 20560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ_d7C8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:48 INFO - PROCESS | 20560 | RSS: Main: 175423488 06:02:48 INFO - PROCESS | 20560 | 06:03:39 INFO - PROCESS | 20560 | 1466600619803 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] 06:05:52 INFO - PROCESS | 20560 | Cycle 1(1): loaded http://localhost:54909/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54909/tests/dromaeo/cssquery-ext.html) 06:05:53 INFO - PROCESS | 20560 | RSS: Main: 312324096 06:05:53 INFO - PROCESS | 20560 | 06:08:56 INFO - PROCESS | 20560 | Cycle 1(1): loaded http://localhost:54909/tests/dromaeo/cssquery-ext.html (next: http://localhost:54909/tests/dromaeo/cssquery-jquery.html) 06:08:57 INFO - PROCESS | 20560 | RSS: Main: 260829184 06:08:57 INFO - PROCESS | 20560 | 06:11:59 INFO - PROCESS | 20560 | Cycle 1(1): loaded http://localhost:54909/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54909/tests/dromaeo/cssquery-mootools.html) 06:12:00 INFO - PROCESS | 20560 | RSS: Main: 266960896 06:12:00 INFO - PROCESS | 20560 | 06:15:02 INFO - PROCESS | 20560 | Cycle 1(1): loaded http://localhost:54909/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54909/tests/dromaeo/cssquery-prototype.html) 06:15:02 INFO - PROCESS | 20560 | RSS: Main: 258048000 06:15:02 INFO - PROCESS | 20560 | 06:18:05 INFO - PROCESS | 20560 | Cycle 1(1): loaded http://localhost:54909/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54909/tests/dromaeo/cssquery-yui.html) 06:18:06 INFO - PROCESS | 20560 | RSS: Main: 236904448 06:18:06 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | Cycle 1(1): loaded http://localhost:54909/tests/dromaeo/cssquery-yui.html (next: http://localhost:54909/tests/dromaeo/cssquery-dojo.html) 06:21:09 INFO - PROCESS | 20560 | RSS: Main: 299368448 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | __start_tp_report 06:21:09 INFO - PROCESS | 20560 | _x_x_mozilla_page_load 06:21:09 INFO - PROCESS | 20560 | _x_x_mozilla_page_load_details 06:21:09 INFO - PROCESS | 20560 | |i|pagename|runs| 06:21:09 INFO - PROCESS | 20560 | |0;dojo.html;2602.973970260297;2643.8281511701725;2666.040225518813;2671.625972363868;2677.8661066946647;4730.314104454852;4760.571548560629;4798.304245884345;4824.63815213859;4826.855194344175;4730.432348118231;4730.550597693222;4737.076270127326;4750.97624511877;4772.164871147544;4290.957090429095;4387.9122417551625;4407.955920440787;4419.204543182226;4602.033572949685;4483.327500874862;4534.047849951514;4552.590266875981;4558.065596552716;4588.220002599566;4380.802863871133;4381.671374646914;4415.2935530315;4423.823047078113;4462.799174037176;4417.469903611555;4426.756528390937;4436.511983681825;4476.731396116244;4490.910181796378;4459.9331010034875;4462.799174037176;4477;4522.8643140705835;4525.615322697575;4728.976355118237;4753.215719406294;4767.666263361566;4773.4510531289;4927.384076990376;5089.847304580869;5142.07442660321;5152.896942061176;5157.4584668610005;5161.561267292284;5144.459831717653;5189.558887494568;5201.08980928336;5205.505476979681;5206.921896171561;4666.556677115703;4791.401074865642;4855.465898751135;4855.902881942412;4934.062528119646;5362.731863406814;5394;5404.648697834628;5412.215228791803;5413.458654134633;4973.204287314013;5165.690058596496;5172.612054095958;5177.611679124081;5178.482151784867;5059.62052846038;5080.060188865072;5113.207452844815;5114.053900028507;5139.537441630271;5063;5083.949160508421;5094.337736094284;5098.1588037973315;5148.510891465305;5005.074061298671;5077.619178561548;5080.364954380702;5083.491650834887;5089.51649593288;4338.958649923996;4356.172327257811;4391.538888416734;4393.406890069864;4402.207602631557;3778.6410291022307;3802.9239415212096;3805.657490825839;3842.269968705993;3843.673287770515;4254.532001479834;4297.205017071852;4346.7609281489185;4399.758013309299;4406.228909940747;5110.207917772751;5126.461721519261;5161.225816127611;5168.069747445421;5216.217567364925;4389.6927215095275;4402.603765661106;4404.845830395985;4448.5551444855255;4450.2434586120435;4500.054988452396;4545.659075569345;4590.77046147698;4633.235516139799;4636.4899861015265;4794.089123066676;4810.512378525681;4833.275008748716;4842.685225460334;4882.584980276716;5170.240847879792;5172.431032586488;5173.844784656466;5178.042062218502;5229.424763275961;4600.378948841863;4781.163296423181;4792.424909010941;4832.033593281288;4879.268109783419;5111.897762044812;5123.769430375568;5128.153854613947;5138.306328645585;5174;5191.92212116811;5200.5059519345605;5206.114960456807;5212.426633070435;5257.658252213594;4954.083494553519;5008.87477813043;5017.67385119966;5053.36832895888;5082.695038297714;5065.417476990193;5066.986602679405;5068.189089745623;5071.898562028812;5089.083964886356;4893.266010098514;4922.138625740409;4959.652824302409;4982.427020892499;4985.9501404985485;5038.193888977746;5047.697138171721;5052.393712754493;5098.5411312982005;5103.157978933435;4873.366462359871;4933.481984391731;4958.851234462972;4981.726005069611;4994.525520075587 06:21:09 INFO - PROCESS | 20560 | |1;ext.html;528.0437756497948;575.6258432019188;582.1675004743219;588.6997631208083;591.4706337827645;26825;39181.60818391815;40179.59820401795;40257.396139057935;40342.798286008605;40087.599124008826;40678.796606017;40745.59254407455;40758.59241407585;40855.79572102135;7457.962710186442;7774.339181169607;7936.841263174733;9960.701178964606;10238.027387398222;9864.90135098647;9970.65102721405;9980.451075190862;9984.600615975352;9985.301028927977;10026.498675066254;10089.697309080702;10093.747656308578;10096.798064038714;10102.545385457635;7533.54798712079;9898.653547125889;10138.898611013943;10143.695689129338;10457.84313235302;10009.89990100097;10062.144717699004;10073.848892266622;10079.395236285847;10095.697129086138;37808.810955945046;38253.234935301414;38289.23421531554;38327.61672383268;38341.23317533634;3135.8588863501195;3221.822799746013;3239.2225865792275;3335.449650807614;3701.148735790783;28542.14373568796;29109.272268193254;29208.123756287347;29486.852565737034;30238.54642180369;3307.2426434162194;3356.9832150839334;3401.0647072055135;3440.673136052071;3458.6887180153653;251762;252312;253798;254418;255281;29387.11838644844;30213.244668883013;51702.74148629308;51986.22020669693;52555.47444525582;31987.20031999172;32209.355812883612;32232.35535289328;32247.67752322494;32269.838650806596;12695.936520317524;12828.102032857798;13020.348982551024;13032.934835325763;13035.804462933063;10895.237333386745;11087.168462365355;11096.1123110151;11307.265027773168;11316.26444281119;7869.803254918673;7885.605719713992;7899.447038707235;7958.84082318362;7965.283124518821;3063.3107550801337;3072.984635076855;3131.3893790710595;3137.90173439299;3154.8422578870964;857.9356548258905;938.6949241496541;995.4972738766876;1012.0688966151158;1020.7499162705036;27375.726242737317;27675.584866227022;28068.71931280661;28170.01404950817;28275.15174544767;895.7178488776015;940.4921342474987;961.1589858873485;979.6571200079915;1027.825269704152;14863.405463781544;14864.331105100297;14914.925425372803;15025.774613380809;15220.619484512976;122174.38912805557;122310;122570;122855;123670.38164809298;32829.507557386656;32869.50695739566;32917.67082329194;33024;33321.83339083289;1079.8704155501391;1082.8705042427391;1128.6219116595869;1180.539589560055;1206.4390058622782;26658.333541661614;28838.567421489115;28934;28958.074218691563;29250.707492924797;41819;41886.74339769812;42118;42247.57752422436;42278;297209;297945;297968;298086;298089;22424;24814.25557233286;24882.50234995326;25399.746002540476;25620.23139305824;40975.59024409718;41363.586364137176;42219.78890105653;42256.57743422526;42426.1514769709;34116.31604391892;34689.30621387609;34864;35244.47133293054;35273;34758;34841.825790870884;35203;35620.28759424849;35627.46558801672;34615;34749.47875781815;34914;35032.649673502936;36675.633243667224;29221.561676575293;29981.70018299789;32952.34095318128;33162.336753265285;33392.66607333896;24999.999999999396;25155;25409.87295063513;25445.618315724907;25684.229473115836 06:21:09 INFO - PROCESS | 20560 | |2;jquery.html;374.8200863585479;379.2415169660677;383.50719325666523;387.6511139974023;391.1472988884231;15753.291101900413;15908.602284942868;17009.319627214896;17017.574560635974;17847.46457606274;14749.336279867404;15541.456049038286;15636.530904072868;15794.921025394857;16240.593985150377;4549.49955504895;4721.386219791422;4753.595944344717;4753.714777113367;4754.286856971447;3471.75697701161;3672.081979505124;5181.274621552967;5427.213054107152;5457.536109430684;5512.972435137819;5514.310711161105;5516.172574113875;5517.420670829565;5533.114701647737;5224.817131400402;5385.380681221651;5385.7576409061685;5392;5403.324584426947;5079.187330027215;5236.031334203185;5242.6330156889035;5247.23915032322;5248;20015.89992050045;20038.79961200384;20151.496212594655;20169.09239084245;20451.795482045138;1772.8315809998157;1884.745559349484;1914.9808501914943;1934.2746470073723;2411.5418070566534;9140.131687489678;9306.208972237368;9799.412035277906;9858.359206651616;11164.665060048212;1747.8689098317677;1751.3957684598793;1759.410597449843;1807.41259090796;1857.2385322017908;66024;66786.3321366785;67048;69066;70396;9945.154661853823;10125.443100629389;10139.847902281472;10265.332753371007;10277.588896444207;14147.151170929777;14221.715565688628;14229.85770142306;14281.85718142826;14302.713945721027;7011.597680463928;7132.643367831588;7224.349808517153;7281.526700764433;7318.377937875233;6763.222229443677;6792.08306878575;6874.9656251718425;7130.714771409189;7248.855022899513;4400.823967041347;4436.6672499562665;4447.644188464915;4459.777011149429;4565.680402371802;1676.8323167683377;1762.5769815244248;1785.21450561755;1788.794288656795;1799.127423199747;640.3724350136891;821.765796747936;909.6088681866861;951.5622813505727;958.1136205352784;16344.67310653804;16732.749008764877;16842;17122.486325410257;17331.480055598353;861.4788053227707;882.1178821178821;888.200619442494;890.3100097424548;917.3578495053489;9110.59002344896;9518;9522.666706665372;9606.711798645912;9767.755806104762;379018;379734;382879;384380;397390;67813;72828.63585682037;73002;76384;77064;862.6635612111281;892.5448021509077;901.3375169250595;915.9084091590788;918.4443411735804;14957.700845983238;14958.476453324081;15108.622284442978;15199.620009499851;15471.149086799884;35350.646493535765;36665.81667091754;37519.43720844135;37591.24817503689;38957.22085558216;49500.25749613831;51360;51577.742111289204;51688;52206.21690674719;7355.5954422507275;7379.298966598165;7386.667599958122;7470.589117598584;7593.430492712958;9449.905500944902;10508.842367364343;11448.94275528617;11643.708907277385;12063.75872482563;10278.691639250834;10518.947405262925;10589.258751887293;10679.252452328263;10786.352818830896;10468.162546996069;10534.209934254808;10802.297850639683;10848.67453976382;10882.564697412015;10066.194704423482;10292.639757608447;10323.141834469867;10416.583336666448;10570.788584228427;7694.1536430993665;7892;7930.722424715107;7951.801204969922;8059.153788852321;7662.463627546018;9492.193163581172;10576.894231057591;10586.8411973822;10591.5233814477 06:21:09 INFO - PROCESS | 20560 | |3;mootools.html;1154.2324354304378;1299.1815156451437;1363.5159518370976;1379.793031045343;1652.876034297428;6971.302869713032;7766.456348055638;8023.719169829057;8067.677292908292;8313.792155196123;7906.209379062091;8114.513129212237;8114.91885081149;8122.59387030649;8140;1850.9907450462797;2121.045529511718;2187.9124835006583;2202.746684131321;2232.6427771556555;2205.823534117275;2224.410531209231;2225.3324002799177;2226.565819665166;2227.7772222777753;2184.584928863511;2192.1450634252656;2236.4520692430297;2238.9104435822546;2240.2271216430304;1830.350225669888;2093.6336141175234;2162.2107930605375;2167.2739632223224;2173.5978843913767;2181.040342249405;2204.4488877780555;2205.7683943186057;2207.128184367166;2209.657503087024;8120.350371970288;8154.633041513087;8160;8170.836583268301;8180.345572354197;4656.068786242765;4783.832565860213;4784.784684689197;4791.520847915181;4795.736234507101;2820.435912817424;2874.6119273897966;2939.941201175986;2953.099304712062;3012.8041677290908;948.170350942925;964.6623681711415;965.1024547171128;970.5632465390532;977.6285011695581;11196.048335891459;11196.272242304305;11196.94401527987;11199.440027998568;11204.887951120467;4436.223660859337;4444.911101777946;4506.909861802746;4509.030558429953;4523.072770082125;9464.810703785886;9540.570674319533;9542.141207291239;9544.236461083097;9546.093121153479;4837.95162048375;4878.048780487842;4883.438404583448;4883.560479556786;4884.95115048852;3779.093017675738;4179.6238338549065;4324.17840610283;4340;4385.276429389115;3605.513255710498;3675.6875665568728;3717.033571271489;3749.343864823645;3785.7917814519915;1200.6938230751102;1214.6416807041944;1221.053683395358;1222.3949145173196;1235.184778046485;701.2496628607444;813.0121901889233;814.9755507334789;819.0908092017855;826.5288785392269;4997.150484417658;5028.32117664118;5059.2916991621205;5080.949190508121;5093.490650934877;420.37364327152324;425.5616714783778;428.220638438046;432.20690033787724;437.3854734098596;3476.756627036134;3484.4947482615385;3513.8243087845503;3514.472829075608;3540.91147721309;9263.768405789775;9816.411015339103;9869.555869985868;9895.208383329316;9901.257405694458;9628.9037109628;9656.034396560288;9793.412395256308;9804.117629413387;9806.460644664468;7488.326050655358;7543.43424243173;7573.583452910033;7586.810329741801;7593.696252149963;5072.087024335655;5073.847784566469;5084.542391184811;5191.273221749034;5261.868453288545;9077.183053525214;9126;9137.77155571116;9233.445993240428;9252.861207081765;9072.319576031956;9406.1064198901;9487.573059212215;9503.857442138235;9513;6245.812625621239;6669;6885.758998435031;6953.617551034742;7021.438284937295;7794.337481313925;7798.064232291934;7821.1005734339005;7844.137144913941;7845.411594130349;7008.4042856355745;7211.67547460376;7223.674934627849;7277.890831637424;7369.889451658122;7107.502474826712;7116;7130.643467826691;7208.855822883618;7264.527805692613;5757.280339957505;6056.9697151513965;6106.175666285172;6211.192544969306;6214.223222097238;4300.806463709203;4357.607815296638;4445.333200020023;4522.231220692424;4534.183846907588;4233.851815186454;4276.31578947367;4287.871363859089;4368.60682538573;4401.713888597231 06:21:09 INFO - PROCESS | 20560 | |4;prototype.html;297.4304207442747;302.24589648826174;302.75476863740374;314.91654711501457;315.2324090838809;4717.9292310615365;4855.975720121403;4868.51314868513;4929.580985616222;4960.47914968928;4663.8367657132;4822.807087716487;4840.128776820171;4865.221564549673;4896.951030489694;3835.2329534093155;3881.0879443330796;3908.8045597720143;3915.373540233556;3919.8432062717457;3599.2441587266703;3657.8171091445456;3854.7879866607327;3872.186840763443;3875.476810630557;3808.6953043756434;3824.7513911595656;3848.6151384861428;3867;3873.283442563121;3807.2195199983935;3807.9056518914626;3812.2375524894856;3817.4846395736636;3832.885013449601;3398.9830050849587;3417.8803741869165;3423.623401425841;3425.3320602482527;3440.638732933031;4605.309203619484;4809.78355973982;4844.878878028077;4865.586425153866;4866.148424025817;4317.438732964726;4365.956340436586;4376.584224498668;4383.430154079981;4410.713303635285;4921.753912304371;5175.611829112794;5181.481851814826;5183.637145399824;5185.922211166836;3668.4313931340685;3670.504481894963;3681.1717363593243;3683.3001729671278;3693.113652723327;5417.431169727161;5442.91835622466;5443.455654434564;5473.17902314656;5476.234501576718;3783.39465685489;3787.280416720814;3798.2783271178387;3800.087978885103;3801.2207497462955;3648.908777280589;3770.887588161499;3799.506064211635;3819.3316169670197;3829.310724069694;4310.52584215736;4320.870373888788;4326.351047342924;4333.631641310524;4340.131973605292;5131.204663277198;5146.330976973044;5150.351887395997;5167.250748641426;5168.7415629218385;1231.6305108467425;1240.7344508601177;1261.4827920552714;1267.2903174222465;1306.751717173734;757.4092208077708;779.6491578789568;781.183663072091;839.2404873589411;839.6977088248226;4027.697922655754;4069.89825254371;4097.279142760048;4098.897527561775;4119.938200926988;4711.764411779397;4714.622830173578;4721.409823772028;4753.738544380092;4777.283407488904;4110.506739191316;4112.375611633388;4234.322508398642;4533.410656614619;4584.977075114603;2831.3346363604537;2838.1343690174695;2845.2175651695948;2853.4721076600895;2866.5556838690036;5001.974990125026;5033.144365457881;5057.924131138036;5061.620378471629;5068.16375298079;5214.687118772886;5457.918131228034;5509.090999985037;5510.889782204334;5512.173174023928;4973.079980203602;4975;4988.852563910321;5014.373203349582;5024.57291130258;5218.504242096995;5311.362636483646;5355.599194511591;5358.544523715372;5391.973040134774;5232.136697444879;5252.606054545848;5264.184051472028;5267.86740850719;5269.736513174403;4985.3020577118505;4987.551120399036;4995.525425084611;5021.4225364083595;5027.296178534935;3874.825632846472;3878.7284890057426;3889.4360317753203;3889.630485103911;3907.374820028782;5069.594432445322;5363.115086010921;5370.019639100181;5375.381831089475;5382.811601593926;4976.5023497649945;4993.402111324486;5107.310513080835;5200.791968321376;5201.401838788588;5127.230915362726;5135.281060651437;5171.9482805172975;5186.58507319406;5187.559057480156;4892.68197567157;5087.720175390241;5089.0839648862075;5106.540411362995;5122.308488354173;5185.248139019896;5193.662411943212;5194.97402512985;5215.947840521546;5228.869278268074;5075.974620126875;5083.161278389024;5087.651772280423;5117.718525481134;5118.41138269089 06:21:09 INFO - PROCESS | 20560 | |5;yui.html;643.1703102997134;678.8608335291266;683.8392977650251;698.1587187439136;716.5879619218947;11958.820617690742;12621.179623324477;12836.614901552945;12838.101332906701;12856.485740570366;12332.691682707937;12432.875671243308;12499.812502812443;12515.812262816065;12548.435320410581;623.0902881792566;766.0347961568436;780.3484090784202;799.5043073294565;803.6343463724021;785.2147852147853;793.9444238903279;794.3724457678427;794.6543253684637;794.8132188935596;822.6709316273478;824.085265355455;825.8389614025267;826.4462809917339;827.1273806134526;654.1986067067851;799.7680672604938;819.5943008210915;821.1501096365263;821.6343727041469;599.4275466929072;601.3715667127861;601.6991504247876;601.8495376155961;602.0908428273339;12046.915777579972;12112.454939527743;12126.151169418144;12135.453904574315;12142.332171730552;12207.694807629792;13052.804207936793;13181.934090329487;13218.272994985273;13292.601221963356;10607.628732994308;10745.247832651718;10946.124310055257;11135.387553684544;11200;3061.9540706889416;3298.043567365461;3337.6161741399806;3341.1313058604696;4047.1905618876344;63599.682001589696;65048.67475662639;66149.66925165392;66376.6681166596;66565;10137.898621013695;10238.744031399274;10342;10374.792504149875;10383;17530;17565.736513952303;17574;17590.296388144332;17632.471025869243;6675.399214070757;6720.495962802809;6962.965185174042;6979.162500499972;7081;3669.43123815809;3759.2293579816073;3772.2078363543965;3773.660370566662;3817.8854634361014;2659.069325735977;2740.1916434651826;2744.7392497712685;2747.917562473129;2749.408877091395;498.95010498949813;499.36331177747934;500.02994191268823;500.5095006893265;510.1276816643581;455.794892298467;533.5278278723358;594.8245267646055;597.2534332084894;604.8820480006444;7332;7657.617119144021;8028.518288902685;8106.47307924983;8371.790705232417;546.0261155921315;546.0635010956229;558.2296430925297;570.1476292942078;573.2175580332815;3636.29092326999;3837.13664425502;3868.5357757069332;3871.845126194977;3917.941230881482;77405;89604.551977241;96352.51823740837;96975.51512242535;97682;65261.67369163219;77707.17196210306;77969;78876.21123788689;79562;64900;68083;69002;69811.65094174497;70240;8804.823903521765;8811.559422029;8986.955065224893;8995;9086.863697044417;42028.36957445702;42249.465032098175;42266.36600450934;43312.78343608262;43501.34747978846;55776.442235577124;61982.69008654928;62369.37630623817;62746.666533345175;63270.36729632829;11265.887341126812;11377.658670239905;11564.537418503165;11669.124815638692;12039.157258991787;12510.311932843417;12621;12933.676658083623;13051.21692698441;13056.086073974731;12046.698832529257;12447.377631118588;12471.875281247072;12595.748085038065;12778.498756723811;12208.633740987785;12308.753824923273;12577.559785407468;12778.68053298675;12819.974402048001;12266.570670026505;12399.814002789784;12653.55712550093;13227.603171904859;13233.206007639572;10246.948765256424;10493.790124197625;10822.891771082188;11165.995060444275;11189.832152517556;10031.598736050477;10175.135113515435;10194.74513137148;10613.257072004886;10957.890421095686 06:21:09 INFO - PROCESS | 20560 | __end_tp_report 06:21:09 INFO - PROCESS | 20560 | __start_cc_report 06:21:09 INFO - PROCESS | 20560 | _x_x_mozilla_cycle_collect,1263 06:21:09 INFO - PROCESS | 20560 | __end_cc_report 06:21:09 INFO - PROCESS | 20560 | __startTimestamp1466601669656__endTimestamp 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | ------- Summary: start ------- 06:21:09 INFO - PROCESS | 20560 | Number of tests: 6 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | [#0] dojo.html Cycles:165 Average:4761.61 Median:4879.27 stddev:510.63 (10.5%) stddev-sans-first:483.31 06:21:09 INFO - PROCESS | 20560 | Values: 2603.0 2643.8 2666.0 2671.6 2677.9 4730.3 4760.6 4798.3 4824.6 4826.9 4730.4 4730.6 4737.1 4751.0 4772.2 4291.0 4387.9 4408.0 4419.2 4602.0 4483.3 4534.0 4552.6 4558.1 4588.2 4380.8 4381.7 4415.3 4423.8 4462.8 4417.5 4426.8 4436.5 4476.7 4490.9 4459.9 4462.8 4477.0 4522.9 4525.6 4729.0 4753.2 4767.7 4773.5 4927.4 5089.8 5142.1 5152.9 5157.5 5161.6 5144.5 5189.6 5201.1 5205.5 5206.9 4666.6 4791.4 4855.5 4855.9 4934.1 5362.7 5394.0 5404.6 5412.2 5413.5 4973.2 5165.7 5172.6 5177.6 5178.5 5059.6 5080.1 5113.2 5114.1 5139.5 5063.0 5083.9 5094.3 5098.2 5148.5 5005.1 5077.6 5080.4 5083.5 5089.5 4339.0 4356.2 4391.5 4393.4 4402.2 3778.6 3802.9 3805.7 3842.3 3843.7 4254.5 4297.2 4346.8 4399.8 4406.2 5110.2 5126.5 5161.2 5168.1 5216.2 4389.7 4402.6 4404.8 4448.6 4450.2 4500.1 4545.7 4590.8 4633.2 4636.5 4794.1 4810.5 4833.3 4842.7 4882.6 5170.2 5172.4 5173.8 5178.0 5229.4 4600.4 4781.2 4792.4 4832.0 4879.3 5111.9 5123.8 5128.2 5138.3 5174.0 5191.9 5200.5 5206.1 5212.4 5257.7 4954.1 5008.9 5017.7 5053.4 5082.7 5065.4 5067.0 5068.2 5071.9 5089.1 4893.3 4922.1 4959.7 4982.4 4986.0 5038.2 5047.7 5052.4 5098.5 5103.2 4873.4 4933.5 4958.9 4981.7 4994.5 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | [#1] ext.html Cycles:180 Average:37891.44 Median:17727.09 stddev:62091.21 (350.3%) stddev-sans-first:62202.01 06:21:09 INFO - PROCESS | 20560 | Values: 528.0 575.6 582.2 588.7 591.5 26825.0 39181.6 40179.6 40257.4 40342.8 40087.6 40678.8 40745.6 40758.6 40855.8 7458.0 7774.3 7936.8 9960.7 10238.0 9864.9 9970.7 9980.5 9984.6 9985.3 10026.5 10089.7 10093.7 10096.8 10102.5 7533.5 9898.7 10138.9 10143.7 10457.8 10009.9 10062.1 10073.8 10079.4 10095.7 37808.8 38253.2 38289.2 38327.6 38341.2 3135.9 3221.8 3239.2 3335.4 3701.1 28542.1 29109.3 29208.1 29486.9 30238.5 3307.2 3357.0 3401.1 3440.7 3458.7 251762.0 252312.0 253798.0 254418.0 255281.0 29387.1 30213.2 51702.7 51986.2 52555.5 31987.2 32209.4 32232.4 32247.7 32269.8 12695.9 12828.1 13020.3 13032.9 13035.8 10895.2 11087.2 11096.1 11307.3 11316.3 7869.8 7885.6 7899.4 7958.8 7965.3 3063.3 3073.0 3131.4 3137.9 3154.8 857.9 938.7 995.5 1012.1 1020.7 27375.7 27675.6 28068.7 28170.0 28275.2 895.7 940.5 961.2 979.7 1027.8 14863.4 14864.3 14914.9 15025.8 15220.6 122174.4 122310.0 122570.0 122855.0 123670.4 32829.5 32869.5 32917.7 33024.0 33321.8 1079.9 1082.9 1128.6 1180.5 1206.4 26658.3 28838.6 28934.0 28958.1 29250.7 41819.0 41886.7 42118.0 42247.6 42278.0 297209.0 297945.0 297968.0 298086.0 298089.0 22424.0 24814.3 24882.5 25399.7 25620.2 40975.6 41363.6 42219.8 42256.6 42426.2 34116.3 34689.3 34864.0 35244.5 35273.0 34758.0 34841.8 35203.0 35620.3 35627.5 34615.0 34749.5 34914.0 35032.6 36675.6 29221.6 29981.7 32952.3 33162.3 33392.7 25000.0 25155.0 25409.9 25445.6 25684.2 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | [#2] jquery.html Cycles:180 Average:23973.36 Median:4442.16 stddev:63472.55 (1428.9%) stddev-sans-first:63625.88 06:21:09 INFO - PROCESS | 20560 | Values: 374.8 379.2 383.5 387.7 391.1 15753.3 15908.6 17009.3 17017.6 17847.5 14749.3 15541.5 15636.5 15794.9 16240.6 4549.5 4721.4 4753.6 4753.7 4754.3 3471.8 3672.1 5181.3 5427.2 5457.5 5513.0 5514.3 5516.2 5517.4 5533.1 5224.8 5385.4 5385.8 5392.0 5403.3 5079.2 5236.0 5242.6 5247.2 5248.0 20015.9 20038.8 20151.5 20169.1 20451.8 1772.8 1884.7 1915.0 1934.3 2411.5 9140.1 9306.2 9799.4 9858.4 11164.7 1747.9 1751.4 1759.4 1807.4 1857.2 66024.0 66786.3 67048.0 69066.0 70396.0 9945.2 10125.4 10139.8 10265.3 10277.6 14147.2 14221.7 14229.9 14281.9 14302.7 7011.6 7132.6 7224.3 7281.5 7318.4 6763.2 6792.1 6875.0 7130.7 7248.9 4400.8 4436.7 4447.6 4459.8 4565.7 1676.8 1762.6 1785.2 1788.8 1799.1 640.4 821.8 909.6 951.6 958.1 16344.7 16732.7 16842.0 17122.5 17331.5 861.5 882.1 888.2 890.3 917.4 9110.6 9518.0 9522.7 9606.7 9767.8 379018.0 379734.0 382879.0 384380.0 397390.0 67813.0 72828.6 73002.0 76384.0 77064.0 862.7 892.5 901.3 915.9 918.4 14957.7 14958.5 15108.6 15199.6 15471.1 35350.6 36665.8 37519.4 37591.2 38957.2 49500.3 51360.0 51577.7 51688.0 52206.2 7355.6 7379.3 7386.7 7470.6 7593.4 9449.9 10508.8 11448.9 11643.7 12063.8 10278.7 10518.9 10589.3 10679.3 10786.4 10468.2 10534.2 10802.3 10848.7 10882.6 10066.2 10292.6 10323.1 10416.6 10570.8 7694.2 7892.0 7930.7 7951.8 8059.2 7662.5 9492.2 10576.9 10586.8 10591.5 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | [#3] mootools.html Cycles:180 Average:5234.44 Median:5012.74 stddev:3024.29 (60.3%) stddev-sans-first:3017.23 06:21:09 INFO - PROCESS | 20560 | Values: 1154.2 1299.2 1363.5 1379.8 1652.9 6971.3 7766.5 8023.7 8067.7 8313.8 7906.2 8114.5 8114.9 8122.6 8140.0 1851.0 2121.0 2187.9 2202.7 2232.6 2205.8 2224.4 2225.3 2226.6 2227.8 2184.6 2192.1 2236.5 2238.9 2240.2 1830.4 2093.6 2162.2 2167.3 2173.6 2181.0 2204.4 2205.8 2207.1 2209.7 8120.4 8154.6 8160.0 8170.8 8180.3 4656.1 4783.8 4784.8 4791.5 4795.7 2820.4 2874.6 2939.9 2953.1 3012.8 948.2 964.7 965.1 970.6 977.6 11196.0 11196.3 11196.9 11199.4 11204.9 4436.2 4444.9 4506.9 4509.0 4523.1 9464.8 9540.6 9542.1 9544.2 9546.1 4838.0 4878.0 4883.4 4883.6 4885.0 3779.1 4179.6 4324.2 4340.0 4385.3 3605.5 3675.7 3717.0 3749.3 3785.8 1200.7 1214.6 1221.1 1222.4 1235.2 701.2 813.0 815.0 819.1 826.5 4997.2 5028.3 5059.3 5080.9 5093.5 420.4 425.6 428.2 432.2 437.4 3476.8 3484.5 3513.8 3514.5 3540.9 9263.8 9816.4 9869.6 9895.2 9901.3 9628.9 9656.0 9793.4 9804.1 9806.5 7488.3 7543.4 7573.6 7586.8 7593.7 5072.1 5073.8 5084.5 5191.3 5261.9 9077.2 9126.0 9137.8 9233.4 9252.9 9072.3 9406.1 9487.6 9503.9 9513.0 6245.8 6669.0 6885.8 6953.6 7021.4 7794.3 7798.1 7821.1 7844.1 7845.4 7008.4 7211.7 7223.7 7277.9 7369.9 7107.5 7116.0 7130.6 7208.9 7264.5 5757.3 6057.0 6106.2 6211.2 6214.2 4300.8 4357.6 4445.3 4522.2 4534.2 4233.9 4276.3 4287.9 4368.6 4401.7 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | [#4] prototype.html Cycles:180 Average:4253.88 Median:4842.50 stddev:1244.25 (25.7%) stddev-sans-first:1211.78 06:21:09 INFO - PROCESS | 20560 | Values: 297.4 302.2 302.8 314.9 315.2 4717.9 4856.0 4868.5 4929.6 4960.5 4663.8 4822.8 4840.1 4865.2 4897.0 3835.2 3881.1 3908.8 3915.4 3919.8 3599.2 3657.8 3854.8 3872.2 3875.5 3808.7 3824.8 3848.6 3867.0 3873.3 3807.2 3807.9 3812.2 3817.5 3832.9 3399.0 3417.9 3423.6 3425.3 3440.6 4605.3 4809.8 4844.9 4865.6 4866.1 4317.4 4366.0 4376.6 4383.4 4410.7 4921.8 5175.6 5181.5 5183.6 5185.9 3668.4 3670.5 3681.2 3683.3 3693.1 5417.4 5442.9 5443.5 5473.2 5476.2 3783.4 3787.3 3798.3 3800.1 3801.2 3648.9 3770.9 3799.5 3819.3 3829.3 4310.5 4320.9 4326.4 4333.6 4340.1 5131.2 5146.3 5150.4 5167.3 5168.7 1231.6 1240.7 1261.5 1267.3 1306.8 757.4 779.6 781.2 839.2 839.7 4027.7 4069.9 4097.3 4098.9 4119.9 4711.8 4714.6 4721.4 4753.7 4777.3 4110.5 4112.4 4234.3 4533.4 4585.0 2831.3 2838.1 2845.2 2853.5 2866.6 5002.0 5033.1 5057.9 5061.6 5068.2 5214.7 5457.9 5509.1 5510.9 5512.2 4973.1 4975.0 4988.9 5014.4 5024.6 5218.5 5311.4 5355.6 5358.5 5392.0 5232.1 5252.6 5264.2 5267.9 5269.7 4985.3 4987.6 4995.5 5021.4 5027.3 3874.8 3878.7 3889.4 3889.6 3907.4 5069.6 5363.1 5370.0 5375.4 5382.8 4976.5 4993.4 5107.3 5200.8 5201.4 5127.2 5135.3 5171.9 5186.6 5187.6 4892.7 5087.7 5089.1 5106.5 5122.3 5185.2 5193.7 5195.0 5215.9 5228.9 5076.0 5083.2 5087.7 5117.7 5118.4 06:21:09 INFO - PROCESS | 20560 | 06:21:09 INFO - PROCESS | 20560 | [#5] yui.html Cycles:180 Average:17255.43 Median:42138.92 stddev:23918.96 (56.8%) stddev-sans-first:23953.53 06:21:09 INFO - PROCESS | 20560 | Values: 643.2 678.9 683.8 698.2 716.6 11958.8 12621.2 12836.6 12838.1 12856.5 12332.7 12432.9 12499.8 12515.8 12548.4 623.1 766.0 780.3 799.5 803.6 785.2 793.9 794.4 794.7 794.8 822.7 824.1 825.8 826.4 827.1 654.2 799.8 819.6 821.2 821.6 599.4 601.4 601.7 601.8 602.1 12046.9 12112.5 12126.2 12135.5 12142.3 12207.7 13052.8 13181.9 13218.3 13292.6 10607.6 10745.2 10946.1 11135.4 11200.0 3062.0 3298.0 3337.6 3341.1 4047.2 63599.7 65048.7 66149.7 66376.7 66565.0 10137.9 10238.7 10342.0 10374.8 10383.0 17530.0 17565.7 17574.0 17590.3 17632.5 6675.4 6720.5 6963.0 6979.2 7081.0 3669.4 3759.2 3772.2 3773.7 3817.9 2659.1 2740.2 2744.7 2747.9 2749.4 499.0 499.4 500.0 500.5 510.1 455.8 533.5 594.8 597.3 604.9 7332.0 7657.6 8028.5 8106.5 8371.8 546.0 546.1 558.2 570.1 573.2 3636.3 3837.1 3868.5 3871.8 3917.9 77405.0 89604.6 96352.5 96975.5 97682.0 65261.7 77707.2 77969.0 78876.2 79562.0 64900.0 68083.0 69002.0 69811.7 70240.0 8804.8 8811.6 8987.0 8995.0 9086.9 42028.4 42249.5 42266.4 43312.8 43501.3 55776.4 61982.7 62369.4 62746.7 63270.4 11265.9 11377.7 11564.5 11669.1 12039.2 12510.3 12621.0 12933.7 13051.2 13056.1 12046.7 12447.4 12471.9 12595.7 12778.5 12208.6 12308.8 12577.6 12778.7 12820.0 12266.6 12399.8 12653.6 13227.6 13233.2 10246.9 10493.8 10822.9 11166.0 11189.8 10031.6 10175.1 10194.7 10613.3 10957.9 06:21:09 INFO - PROCESS | 20560 | -------- Summary: end -------- 06:21:09 INFO - PROCESS | 20560 | 06:21:10 INFO - TEST-INFO | 20560: exit 0 06:21:10 INFO - TEST-OK | dromaeo_css | took 1119914ms 06:21:10 INFO - TEST-START | kraken 06:21:10 INFO - operating with platform_type : linux_ 06:21:10 INFO - Initialising browser for kraken test... 06:21:10 INFO - TEST-INFO | started process 20739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXTdgO3/profile http://localhost:54909/getInfo.html) 06:21:14 INFO - PROCESS | 20739 | __metrics Screen width/height:1600/1200 06:21:14 INFO - PROCESS | 20739 | colorDepth:24 06:21:14 INFO - PROCESS | 20739 | Browser inner width/height: 1024/697 06:21:14 INFO - PROCESS | 20739 | __metrics 06:21:15 INFO - PROCESS | 20739 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:16 INFO - TEST-INFO | 20739: exit 0 06:21:16 INFO - Browser initialized. 06:21:16 INFO - Running cycle 1/1 for kraken test... 06:21:16 INFO - TEST-INFO | started process 20822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXTdgO3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:28 INFO - PROCESS | 20822 | RSS: Main: 175095808 06:21:28 INFO - PROCESS | 20822 | 06:21:31 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54909/tests/kraken/driver.html?testName=audio-beat-detection) 06:21:32 INFO - PROCESS | 20822 | RSS: Main: 233635840 06:21:32 INFO - PROCESS | 20822 | 06:21:35 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54909/tests/kraken/driver.html?testName=audio-dft) 06:21:35 INFO - PROCESS | 20822 | RSS: Main: 222580736 06:21:35 INFO - PROCESS | 20822 | 06:21:39 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54909/tests/kraken/driver.html?testName=audio-fft) 06:21:39 INFO - PROCESS | 20822 | RSS: Main: 288681984 06:21:39 INFO - PROCESS | 20822 | 06:21:42 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54909/tests/kraken/driver.html?testName=audio-oscillator) 06:21:42 INFO - PROCESS | 20822 | RSS: Main: 198574080 06:21:42 INFO - PROCESS | 20822 | 06:21:44 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54909/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:45 INFO - PROCESS | 20822 | RSS: Main: 203583488 06:21:45 INFO - PROCESS | 20822 | 06:21:48 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54909/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:49 INFO - PROCESS | 20822 | RSS: Main: 238125056 06:21:49 INFO - PROCESS | 20822 | 06:21:52 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54909/tests/kraken/driver.html?testName=imaging-desaturate) 06:21:53 INFO - PROCESS | 20822 | RSS: Main: 234315776 06:21:53 INFO - PROCESS | 20822 | 06:21:56 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54909/tests/kraken/driver.html?testName=json-parse-financial) 06:21:57 INFO - PROCESS | 20822 | RSS: Main: 237043712 06:21:57 INFO - PROCESS | 20822 | 06:21:58 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54909/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:59 INFO - PROCESS | 20822 | RSS: Main: 224215040 06:21:59 INFO - PROCESS | 20822 | 06:22:01 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:22:01 INFO - PROCESS | 20822 | RSS: Main: 229867520 06:22:01 INFO - PROCESS | 20822 | 06:22:04 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:22:04 INFO - PROCESS | 20822 | RSS: Main: 237989888 06:22:04 INFO - PROCESS | 20822 | 06:22:07 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:22:08 INFO - PROCESS | 20822 | RSS: Main: 239808512 06:22:08 INFO - PROCESS | 20822 | 06:22:11 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:22:11 INFO - PROCESS | 20822 | RSS: Main: 238022656 06:22:11 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | Cycle 1(1): loaded http://localhost:54909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54909/tests/kraken/driver.html?testName=ai-astar) 06:22:13 INFO - PROCESS | 20822 | RSS: Main: 280473600 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | __start_tp_report 06:22:13 INFO - PROCESS | 20822 | _x_x_mozilla_page_load 06:22:13 INFO - PROCESS | 20822 | _x_x_mozilla_page_load_details 06:22:13 INFO - PROCESS | 20822 | |i|pagename|runs| 06:22:13 INFO - PROCESS | 20822 | |0;ai-astar;105;114;116;115;112;112;112;111;114;113 06:22:13 INFO - PROCESS | 20822 | |1;audio-beat-detection;156;135;134;185;133;153;155;135;190;131 06:22:13 INFO - PROCESS | 20822 | |2;audio-dft;161;161;160;161;160;161;162;160;161;160 06:22:13 INFO - PROCESS | 20822 | |3;audio-fft;75;76;75;124;76;77;75;76;99;74 06:22:13 INFO - PROCESS | 20822 | |4;audio-oscillator;87;87;120;85;86;86;126;86;86;129 06:22:13 INFO - PROCESS | 20822 | |5;imaging-gaussian-blur;116;116;117;118;116;117;117;117;116;117 06:22:13 INFO - PROCESS | 20822 | |6;imaging-darkroom;147;147;149;148;148;147;150;148;147;148 06:22:13 INFO - PROCESS | 20822 | |7;imaging-desaturate;95;95;95;95;95;94;94;96;95;95 06:22:13 INFO - PROCESS | 20822 | |8;json-parse-financial;62;65;62;64;64;62;63;63;62;63 06:22:13 INFO - PROCESS | 20822 | |9;json-stringify-tinderbox;65;65;67;65;65;65;65;65;65;67 06:22:13 INFO - PROCESS | 20822 | |10;stanford-crypto-aes;86;87;83;83;83;84;83;83;114;84 06:22:13 INFO - PROCESS | 20822 | |11;stanford-crypto-ccm;143;129;133;126;133;133;135;141;143;130 06:22:13 INFO - PROCESS | 20822 | |12;stanford-crypto-pbkdf2;169;171;169;172;171;169;174;169;168;184 06:22:13 INFO - PROCESS | 20822 | |13;stanford-crypto-sha256-iterative;68;68;68;67;67;69;72;69;67;66 06:22:13 INFO - PROCESS | 20822 | __end_tp_report 06:22:13 INFO - PROCESS | 20822 | __start_cc_report 06:22:13 INFO - PROCESS | 20822 | _x_x_mozilla_cycle_collect,1925 06:22:13 INFO - PROCESS | 20822 | __end_cc_report 06:22:13 INFO - PROCESS | 20822 | __startTimestamp1466601733826__endTimestamp 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | ------- Summary: start ------- 06:22:13 INFO - PROCESS | 20822 | Number of tests: 14 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.03 (2.7%) stddev-sans-first:1.64 06:22:13 INFO - PROCESS | 20822 | Values: 105.0 114.0 116.0 115.0 112.0 112.0 112.0 111.0 114.0 113.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:154.00 stddev:21.72 (14.1%) stddev-sans-first:22.95 06:22:13 INFO - PROCESS | 20822 | Values: 156.0 135.0 134.0 185.0 133.0 153.0 155.0 135.0 190.0 131.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 06:22:13 INFO - PROCESS | 20822 | Values: 161.0 161.0 160.0 161.0 160.0 161.0 162.0 160.0 161.0 160.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:16.30 (21.5%) stddev-sans-first:17.05 06:22:13 INFO - PROCESS | 20822 | Values: 75.0 76.0 75.0 124.0 76.0 77.0 75.0 76.0 99.0 74.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:86.00 stddev:18.90 (22.0%) stddev-sans-first:19.64 06:22:13 INFO - PROCESS | 20822 | Values: 87.0 87.0 120.0 85.0 86.0 86.0 126.0 86.0 86.0 129.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 06:22:13 INFO - PROCESS | 20822 | Values: 116.0 116.0 117.0 118.0 116.0 117.0 117.0 117.0 116.0 117.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 06:22:13 INFO - PROCESS | 20822 | Values: 147.0 147.0 149.0 148.0 148.0 147.0 150.0 148.0 147.0 148.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:22:13 INFO - PROCESS | 20822 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 96.0 95.0 95.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.05 (1.7%) stddev-sans-first:1.05 06:22:13 INFO - PROCESS | 20822 | Values: 62.0 65.0 62.0 64.0 64.0 62.0 63.0 63.0 62.0 63.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 06:22:13 INFO - PROCESS | 20822 | Values: 65.0 65.0 67.0 65.0 65.0 65.0 65.0 65.0 65.0 67.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:83.50 stddev:9.59 (11.5%) stddev-sans-first:10.17 06:22:13 INFO - PROCESS | 20822 | Values: 86.0 87.0 83.0 83.0 83.0 84.0 83.0 83.0 114.0 84.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:134.00 stddev:5.93 (4.4%) stddev-sans-first:5.45 06:22:13 INFO - PROCESS | 20822 | Values: 143.0 129.0 133.0 126.0 133.0 133.0 135.0 141.0 143.0 130.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.00 stddev:4.72 (2.8%) stddev-sans-first:4.91 06:22:13 INFO - PROCESS | 20822 | Values: 169.0 171.0 169.0 172.0 171.0 169.0 174.0 169.0 168.0 184.0 06:22:13 INFO - PROCESS | 20822 | 06:22:13 INFO - PROCESS | 20822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.66 (2.4%) stddev-sans-first:1.76 06:22:13 INFO - PROCESS | 20822 | Values: 68.0 68.0 68.0 67.0 67.0 69.0 72.0 69.0 67.0 66.0 06:22:13 INFO - PROCESS | 20822 | -------- Summary: end -------- 06:22:13 INFO - PROCESS | 20822 | 06:22:14 INFO - TEST-INFO | 20822: exit 0 06:22:14 INFO - TEST-OK | kraken | took 64417ms 06:22:14 INFO - SUITE-END | took 1184s 06:22:14 INFO - Completed test suite (00:19:44) 06:22:14 INFO - javascript benchmark 06:22:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.973970260297, 2643.8281511701725, 2666.040225518813, 2671.625972363868, 2677.8661066946647, 4730.314104454852, 4760.571548560629, 4798.304245884345, 4824.63815213859, 4826.855194344175, 4730.432348118231, 4730.550597693222, 4737.076270127326, 4750.97624511877, 4772.164871147544, 4290.957090429095, 4387.9122417551625, 4407.955920440787, 4419.204543182226, 4602.033572949685, 4483.327500874862, 4534.047849951514, 4552.590266875981, 4558.065596552716, 4588.220002599566, 4380.802863871133, 4381.671374646914, 4415.2935530315, 4423.823047078113, 4462.799174037176, 4417.469903611555, 4426.756528390937, 4436.511983681825, 4476.731396116244, 4490.910181796378, 4459.9331010034875, 4462.799174037176, 4477.0, 4522.8643140705835, 4525.615322697575, 4728.976355118237, 4753.215719406294, 4767.666263361566, 4773.4510531289, 4927.384076990376, 5089.847304580869, 5142.07442660321, 5152.896942061176, 5157.4584668610005, 5161.561267292284, 5144.459831717653, 5189.558887494568, 5201.08980928336, 5205.505476979681, 5206.921896171561, 4666.556677115703, 4791.401074865642, 4855.465898751135, 4855.902881942412, 4934.062528119646, 5362.731863406814, 5394.0, 5404.648697834628, 5412.215228791803, 5413.458654134633, 4973.204287314013, 5165.690058596496, 5172.612054095958, 5177.611679124081, 5178.482151784867, 5059.62052846038, 5080.060188865072, 5113.207452844815, 5114.053900028507, 5139.537441630271, 5063.0, 5083.949160508421, 5094.337736094284, 5098.1588037973315, 5148.510891465305, 5005.074061298671, 5077.619178561548, 5080.364954380702, 5083.491650834887, 5089.51649593288, 4338.958649923996, 4356.172327257811, 4391.538888416734, 4393.406890069864, 4402.207602631557, 3778.6410291022307, 3802.9239415212096, 3805.657490825839, 3842.269968705993, 3843.673287770515, 4254.532001479834, 4297.205017071852, 4346.7609281489185, 4399.758013309299, 4406.228909940747, 5110.207917772751, 5126.461721519261, 5161.225816127611, 5168.069747445421, 5216.217567364925, 4389.6927215095275, 4402.603765661106, 4404.845830395985, 4448.5551444855255, 4450.2434586120435, 4500.054988452396, 4545.659075569345, 4590.77046147698, 4633.235516139799, 4636.4899861015265, 4794.089123066676, 4810.512378525681, 4833.275008748716, 4842.685225460334, 4882.584980276716, 5170.240847879792, 5172.431032586488, 5173.844784656466, 5178.042062218502, 5229.424763275961, 4600.378948841863, 4781.163296423181, 4792.424909010941, 4832.033593281288, 4879.268109783419, 5111.897762044812, 5123.769430375568, 5128.153854613947, 5138.306328645585, 5174.0, 5191.92212116811, 5200.5059519345605, 5206.114960456807, 5212.426633070435, 5257.658252213594, 4954.083494553519, 5008.87477813043, 5017.67385119966, 5053.36832895888, 5082.695038297714, 5065.417476990193, 5066.986602679405, 5068.189089745623, 5071.898562028812, 5089.083964886356, 4893.266010098514, 4922.138625740409, 4959.652824302409, 4982.427020892499, 4985.9501404985485, 5038.193888977746, 5047.697138171721, 5052.393712754493, 5098.5411312982005, 5103.157978933435, 4873.366462359871, 4933.481984391731, 4958.851234462972, 4981.726005069611, 4994.525520075587], "value": 4728.1622305966175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.0437756497948, 575.6258432019188, 582.1675004743219, 588.6997631208083, 591.4706337827645, 26825.0, 39181.60818391815, 40179.59820401795, 40257.396139057935, 40342.798286008605, 40087.599124008826, 40678.796606017, 40745.59254407455, 40758.59241407585, 40855.79572102135, 7457.962710186442, 7774.339181169607, 7936.841263174733, 9960.701178964606, 10238.027387398222, 9864.90135098647, 9970.65102721405, 9980.451075190862, 9984.600615975352, 9985.301028927977, 10026.498675066254, 10089.697309080702, 10093.747656308578, 10096.798064038714, 10102.545385457635, 7533.54798712079, 9898.653547125889, 10138.898611013943, 10143.695689129338, 10457.84313235302, 10009.89990100097, 10062.144717699004, 10073.848892266622, 10079.395236285847, 10095.697129086138, 37808.810955945046, 38253.234935301414, 38289.23421531554, 38327.61672383268, 38341.23317533634, 3135.8588863501195, 3221.822799746013, 3239.2225865792275, 3335.449650807614, 3701.148735790783, 28542.14373568796, 29109.272268193254, 29208.123756287347, 29486.852565737034, 30238.54642180369, 3307.2426434162194, 3356.9832150839334, 3401.0647072055135, 3440.673136052071, 3458.6887180153653, 251762.0, 252312.0, 253798.0, 254418.0, 255281.0, 29387.11838644844, 30213.244668883013, 51702.74148629308, 51986.22020669693, 52555.47444525582, 31987.20031999172, 32209.355812883612, 32232.35535289328, 32247.67752322494, 32269.838650806596, 12695.936520317524, 12828.102032857798, 13020.348982551024, 13032.934835325763, 13035.804462933063, 10895.237333386745, 11087.168462365355, 11096.1123110151, 11307.265027773168, 11316.26444281119, 7869.803254918673, 7885.605719713992, 7899.447038707235, 7958.84082318362, 7965.283124518821, 3063.3107550801337, 3072.984635076855, 3131.3893790710595, 3137.90173439299, 3154.8422578870964, 857.9356548258905, 938.6949241496541, 995.4972738766876, 1012.0688966151158, 1020.7499162705036, 27375.726242737317, 27675.584866227022, 28068.71931280661, 28170.01404950817, 28275.15174544767, 895.7178488776015, 940.4921342474987, 961.1589858873485, 979.6571200079915, 1027.825269704152, 14863.405463781544, 14864.331105100297, 14914.925425372803, 15025.774613380809, 15220.619484512976, 122174.38912805557, 122310.0, 122570.0, 122855.0, 123670.38164809298, 32829.507557386656, 32869.50695739566, 32917.67082329194, 33024.0, 33321.83339083289, 1079.8704155501391, 1082.8705042427391, 1128.6219116595869, 1180.539589560055, 1206.4390058622782, 26658.333541661614, 28838.567421489115, 28934.0, 28958.074218691563, 29250.707492924797, 41819.0, 41886.74339769812, 42118.0, 42247.57752422436, 42278.0, 297209.0, 297945.0, 297968.0, 298086.0, 298089.0, 22424.0, 24814.25557233286, 24882.50234995326, 25399.746002540476, 25620.23139305824, 40975.59024409718, 41363.586364137176, 42219.78890105653, 42256.57743422526, 42426.1514769709, 34116.31604391892, 34689.30621387609, 34864.0, 35244.47133293054, 35273.0, 34758.0, 34841.825790870884, 35203.0, 35620.28759424849, 35627.46558801672, 34615.0, 34749.47875781815, 34914.0, 35032.649673502936, 36675.633243667224, 29221.561676575293, 29981.70018299789, 32952.34095318128, 33162.336753265285, 33392.66607333896, 24999.999999999396, 25155.0, 25409.87295063513, 25445.618315724907, 25684.229473115836], "value": 16078.261485221403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.8200863585479, 379.2415169660677, 383.50719325666523, 387.6511139974023, 391.1472988884231, 15753.291101900413, 15908.602284942868, 17009.319627214896, 17017.574560635974, 17847.46457606274, 14749.336279867404, 15541.456049038286, 15636.530904072868, 15794.921025394857, 16240.593985150377, 4549.49955504895, 4721.386219791422, 4753.595944344717, 4753.714777113367, 4754.286856971447, 3471.75697701161, 3672.081979505124, 5181.274621552967, 5427.213054107152, 5457.536109430684, 5512.972435137819, 5514.310711161105, 5516.172574113875, 5517.420670829565, 5533.114701647737, 5224.817131400402, 5385.380681221651, 5385.7576409061685, 5392.0, 5403.324584426947, 5079.187330027215, 5236.031334203185, 5242.6330156889035, 5247.23915032322, 5248.0, 20015.89992050045, 20038.79961200384, 20151.496212594655, 20169.09239084245, 20451.795482045138, 1772.8315809998157, 1884.745559349484, 1914.9808501914943, 1934.2746470073723, 2411.5418070566534, 9140.131687489678, 9306.208972237368, 9799.412035277906, 9858.359206651616, 11164.665060048212, 1747.8689098317677, 1751.3957684598793, 1759.410597449843, 1807.41259090796, 1857.2385322017908, 66024.0, 66786.3321366785, 67048.0, 69066.0, 70396.0, 9945.154661853823, 10125.443100629389, 10139.847902281472, 10265.332753371007, 10277.588896444207, 14147.151170929777, 14221.715565688628, 14229.85770142306, 14281.85718142826, 14302.713945721027, 7011.597680463928, 7132.643367831588, 7224.349808517153, 7281.526700764433, 7318.377937875233, 6763.222229443677, 6792.08306878575, 6874.9656251718425, 7130.714771409189, 7248.855022899513, 4400.823967041347, 4436.6672499562665, 4447.644188464915, 4459.777011149429, 4565.680402371802, 1676.8323167683377, 1762.5769815244248, 1785.21450561755, 1788.794288656795, 1799.127423199747, 640.3724350136891, 821.765796747936, 909.6088681866861, 951.5622813505727, 958.1136205352784, 16344.67310653804, 16732.749008764877, 16842.0, 17122.486325410257, 17331.480055598353, 861.4788053227707, 882.1178821178821, 888.200619442494, 890.3100097424548, 917.3578495053489, 9110.59002344896, 9518.0, 9522.666706665372, 9606.711798645912, 9767.755806104762, 379018.0, 379734.0, 382879.0, 384380.0, 397390.0, 67813.0, 72828.63585682037, 73002.0, 76384.0, 77064.0, 862.6635612111281, 892.5448021509077, 901.3375169250595, 915.9084091590788, 918.4443411735804, 14957.700845983238, 14958.476453324081, 15108.622284442978, 15199.620009499851, 15471.149086799884, 35350.646493535765, 36665.81667091754, 37519.43720844135, 37591.24817503689, 38957.22085558216, 49500.25749613831, 51360.0, 51577.742111289204, 51688.0, 52206.21690674719, 7355.5954422507275, 7379.298966598165, 7386.667599958122, 7470.589117598584, 7593.430492712958, 9449.905500944902, 10508.842367364343, 11448.94275528617, 11643.708907277385, 12063.75872482563, 10278.691639250834, 10518.947405262925, 10589.258751887293, 10679.252452328263, 10786.352818830896, 10468.162546996069, 10534.209934254808, 10802.297850639683, 10848.67453976382, 10882.564697412015, 10066.194704423482, 10292.639757608447, 10323.141834469867, 10416.583336666448, 10570.788584228427, 7694.1536430993665, 7892.0, 7930.722424715107, 7951.801204969922, 8059.153788852321, 7662.463627546018, 9492.193163581172, 10576.894231057591, 10586.8411973822, 10591.5233814477], "value": 8141.0697071243285, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1154.2324354304378, 1299.1815156451437, 1363.5159518370976, 1379.793031045343, 1652.876034297428, 6971.302869713032, 7766.456348055638, 8023.719169829057, 8067.677292908292, 8313.792155196123, 7906.209379062091, 8114.513129212237, 8114.91885081149, 8122.59387030649, 8140.0, 1850.9907450462797, 2121.045529511718, 2187.9124835006583, 2202.746684131321, 2232.6427771556555, 2205.823534117275, 2224.410531209231, 2225.3324002799177, 2226.565819665166, 2227.7772222777753, 2184.584928863511, 2192.1450634252656, 2236.4520692430297, 2238.9104435822546, 2240.2271216430304, 1830.350225669888, 2093.6336141175234, 2162.2107930605375, 2167.2739632223224, 2173.5978843913767, 2181.040342249405, 2204.4488877780555, 2205.7683943186057, 2207.128184367166, 2209.657503087024, 8120.350371970288, 8154.633041513087, 8160.0, 8170.836583268301, 8180.345572354197, 4656.068786242765, 4783.832565860213, 4784.784684689197, 4791.520847915181, 4795.736234507101, 2820.435912817424, 2874.6119273897966, 2939.941201175986, 2953.099304712062, 3012.8041677290908, 948.170350942925, 964.6623681711415, 965.1024547171128, 970.5632465390532, 977.6285011695581, 11196.048335891459, 11196.272242304305, 11196.94401527987, 11199.440027998568, 11204.887951120467, 4436.223660859337, 4444.911101777946, 4506.909861802746, 4509.030558429953, 4523.072770082125, 9464.810703785886, 9540.570674319533, 9542.141207291239, 9544.236461083097, 9546.093121153479, 4837.95162048375, 4878.048780487842, 4883.438404583448, 4883.560479556786, 4884.95115048852, 3779.093017675738, 4179.6238338549065, 4324.17840610283, 4340.0, 4385.276429389115, 3605.513255710498, 3675.6875665568728, 3717.033571271489, 3749.343864823645, 3785.7917814519915, 1200.6938230751102, 1214.6416807041944, 1221.053683395358, 1222.3949145173196, 1235.184778046485, 701.2496628607444, 813.0121901889233, 814.9755507334789, 819.0908092017855, 826.5288785392269, 4997.150484417658, 5028.32117664118, 5059.2916991621205, 5080.949190508121, 5093.490650934877, 420.37364327152324, 425.5616714783778, 428.220638438046, 432.20690033787724, 437.3854734098596, 3476.756627036134, 3484.4947482615385, 3513.8243087845503, 3514.472829075608, 3540.91147721309, 9263.768405789775, 9816.411015339103, 9869.555869985868, 9895.208383329316, 9901.257405694458, 9628.9037109628, 9656.034396560288, 9793.412395256308, 9804.117629413387, 9806.460644664468, 7488.326050655358, 7543.43424243173, 7573.583452910033, 7586.810329741801, 7593.696252149963, 5072.087024335655, 5073.847784566469, 5084.542391184811, 5191.273221749034, 5261.868453288545, 9077.183053525214, 9126.0, 9137.77155571116, 9233.445993240428, 9252.861207081765, 9072.319576031956, 9406.1064198901, 9487.573059212215, 9503.857442138235, 9513.0, 6245.812625621239, 6669.0, 6885.758998435031, 6953.617551034742, 7021.438284937295, 7794.337481313925, 7798.064232291934, 7821.1005734339005, 7844.137144913941, 7845.411594130349, 7008.4042856355745, 7211.67547460376, 7223.674934627849, 7277.890831637424, 7369.889451658122, 7107.502474826712, 7116.0, 7130.643467826691, 7208.855822883618, 7264.527805692613, 5757.280339957505, 6056.9697151513965, 6106.175666285172, 6211.192544969306, 6214.223222097238, 4300.806463709203, 4357.607815296638, 4445.333200020023, 4522.231220692424, 4534.183846907588, 4233.851815186454, 4276.31578947367, 4287.871363859089, 4368.60682538573, 4401.713888597231], "value": 4107.666376541656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.4304207442747, 302.24589648826174, 302.75476863740374, 314.91654711501457, 315.2324090838809, 4717.9292310615365, 4855.975720121403, 4868.51314868513, 4929.580985616222, 4960.47914968928, 4663.8367657132, 4822.807087716487, 4840.128776820171, 4865.221564549673, 4896.951030489694, 3835.2329534093155, 3881.0879443330796, 3908.8045597720143, 3915.373540233556, 3919.8432062717457, 3599.2441587266703, 3657.8171091445456, 3854.7879866607327, 3872.186840763443, 3875.476810630557, 3808.6953043756434, 3824.7513911595656, 3848.6151384861428, 3867.0, 3873.283442563121, 3807.2195199983935, 3807.9056518914626, 3812.2375524894856, 3817.4846395736636, 3832.885013449601, 3398.9830050849587, 3417.8803741869165, 3423.623401425841, 3425.3320602482527, 3440.638732933031, 4605.309203619484, 4809.78355973982, 4844.878878028077, 4865.586425153866, 4866.148424025817, 4317.438732964726, 4365.956340436586, 4376.584224498668, 4383.430154079981, 4410.713303635285, 4921.753912304371, 5175.611829112794, 5181.481851814826, 5183.637145399824, 5185.922211166836, 3668.4313931340685, 3670.504481894963, 3681.1717363593243, 3683.3001729671278, 3693.113652723327, 5417.431169727161, 5442.91835622466, 5443.455654434564, 5473.17902314656, 5476.234501576718, 3783.39465685489, 3787.280416720814, 3798.2783271178387, 3800.087978885103, 3801.2207497462955, 3648.908777280589, 3770.887588161499, 3799.506064211635, 3819.3316169670197, 3829.310724069694, 4310.52584215736, 4320.870373888788, 4326.351047342924, 4333.631641310524, 4340.131973605292, 5131.204663277198, 5146.330976973044, 5150.351887395997, 5167.250748641426, 5168.7415629218385, 1231.6305108467425, 1240.7344508601177, 1261.4827920552714, 1267.2903174222465, 1306.751717173734, 757.4092208077708, 779.6491578789568, 781.183663072091, 839.2404873589411, 839.6977088248226, 4027.697922655754, 4069.89825254371, 4097.279142760048, 4098.897527561775, 4119.938200926988, 4711.764411779397, 4714.622830173578, 4721.409823772028, 4753.738544380092, 4777.283407488904, 4110.506739191316, 4112.375611633388, 4234.322508398642, 4533.410656614619, 4584.977075114603, 2831.3346363604537, 2838.1343690174695, 2845.2175651695948, 2853.4721076600895, 2866.5556838690036, 5001.974990125026, 5033.144365457881, 5057.924131138036, 5061.620378471629, 5068.16375298079, 5214.687118772886, 5457.918131228034, 5509.090999985037, 5510.889782204334, 5512.173174023928, 4973.079980203602, 4975.0, 4988.852563910321, 5014.373203349582, 5024.57291130258, 5218.504242096995, 5311.362636483646, 5355.599194511591, 5358.544523715372, 5391.973040134774, 5232.136697444879, 5252.606054545848, 5264.184051472028, 5267.86740850719, 5269.736513174403, 4985.3020577118505, 4987.551120399036, 4995.525425084611, 5021.4225364083595, 5027.296178534935, 3874.825632846472, 3878.7284890057426, 3889.4360317753203, 3889.630485103911, 3907.374820028782, 5069.594432445322, 5363.115086010921, 5370.019639100181, 5375.381831089475, 5382.811601593926, 4976.5023497649945, 4993.402111324486, 5107.310513080835, 5200.791968321376, 5201.401838788588, 5127.230915362726, 5135.281060651437, 5171.9482805172975, 5186.58507319406, 5187.559057480156, 4892.68197567157, 5087.720175390241, 5089.0839648862075, 5106.540411362995, 5122.308488354173, 5185.248139019896, 5193.662411943212, 5194.97402512985, 5215.947840521546, 5228.869278268074, 5075.974620126875, 5083.161278389024, 5087.651772280423, 5117.718525481134, 5118.41138269089], "value": 3853.057602916495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.1703102997134, 678.8608335291266, 683.8392977650251, 698.1587187439136, 716.5879619218947, 11958.820617690742, 12621.179623324477, 12836.614901552945, 12838.101332906701, 12856.485740570366, 12332.691682707937, 12432.875671243308, 12499.812502812443, 12515.812262816065, 12548.435320410581, 623.0902881792566, 766.0347961568436, 780.3484090784202, 799.5043073294565, 803.6343463724021, 785.2147852147853, 793.9444238903279, 794.3724457678427, 794.6543253684637, 794.8132188935596, 822.6709316273478, 824.085265355455, 825.8389614025267, 826.4462809917339, 827.1273806134526, 654.1986067067851, 799.7680672604938, 819.5943008210915, 821.1501096365263, 821.6343727041469, 599.4275466929072, 601.3715667127861, 601.6991504247876, 601.8495376155961, 602.0908428273339, 12046.915777579972, 12112.454939527743, 12126.151169418144, 12135.453904574315, 12142.332171730552, 12207.694807629792, 13052.804207936793, 13181.934090329487, 13218.272994985273, 13292.601221963356, 10607.628732994308, 10745.247832651718, 10946.124310055257, 11135.387553684544, 11200.0, 3061.9540706889416, 3298.043567365461, 3337.6161741399806, 3341.1313058604696, 4047.1905618876344, 63599.682001589696, 65048.67475662639, 66149.66925165392, 66376.6681166596, 66565.0, 10137.898621013695, 10238.744031399274, 10342.0, 10374.792504149875, 10383.0, 17530.0, 17565.736513952303, 17574.0, 17590.296388144332, 17632.471025869243, 6675.399214070757, 6720.495962802809, 6962.965185174042, 6979.162500499972, 7081.0, 3669.43123815809, 3759.2293579816073, 3772.2078363543965, 3773.660370566662, 3817.8854634361014, 2659.069325735977, 2740.1916434651826, 2744.7392497712685, 2747.917562473129, 2749.408877091395, 498.95010498949813, 499.36331177747934, 500.02994191268823, 500.5095006893265, 510.1276816643581, 455.794892298467, 533.5278278723358, 594.8245267646055, 597.2534332084894, 604.8820480006444, 7332.0, 7657.617119144021, 8028.518288902685, 8106.47307924983, 8371.790705232417, 546.0261155921315, 546.0635010956229, 558.2296430925297, 570.1476292942078, 573.2175580332815, 3636.29092326999, 3837.13664425502, 3868.5357757069332, 3871.845126194977, 3917.941230881482, 77405.0, 89604.551977241, 96352.51823740837, 96975.51512242535, 97682.0, 65261.67369163219, 77707.17196210306, 77969.0, 78876.21123788689, 79562.0, 64900.0, 68083.0, 69002.0, 69811.65094174497, 70240.0, 8804.823903521765, 8811.559422029, 8986.955065224893, 8995.0, 9086.863697044417, 42028.36957445702, 42249.465032098175, 42266.36600450934, 43312.78343608262, 43501.34747978846, 55776.442235577124, 61982.69008654928, 62369.37630623817, 62746.666533345175, 63270.36729632829, 11265.887341126812, 11377.658670239905, 11564.537418503165, 11669.124815638692, 12039.157258991787, 12510.311932843417, 12621.0, 12933.676658083623, 13051.21692698441, 13056.086073974731, 12046.698832529257, 12447.377631118588, 12471.875281247072, 12595.748085038065, 12778.498756723811, 12208.633740987785, 12308.753824923273, 12577.559785407468, 12778.68053298675, 12819.974402048001, 12266.570670026505, 12399.814002789784, 12653.55712550093, 13227.603171904859, 13233.206007639572, 10246.948765256424, 10493.790124197625, 10822.891771082188, 11165.995060444275, 11189.832152517556, 10031.598736050477, 10175.135113515435, 10194.74513137148, 10613.257072004886, 10957.890421095686], "value": 6529.707302786373, "unit": "score"}], "name": "dromaeo_css", "value": 6324.0030256922655, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 116.0, 115.0, 112.0, 112.0, 112.0, 111.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 134.0, 185.0, 133.0, 153.0, 155.0, 135.0, 190.0, 131.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 124.0, 76.0, 77.0, 75.0, 76.0, 99.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 120.0, 85.0, 86.0, 86.0, 126.0, 86.0, 86.0, 129.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 150.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 64.0, 64.0, 62.0, 63.0, 63.0, 62.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 114.0, 84.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 129.0, 133.0, 126.0, 133.0, 133.0, 135.0, 141.0, 143.0, 130.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 169.0, 172.0, 171.0, 169.0, 174.0, 169.0, 168.0, 184.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 69.0, 72.0, 69.0, 67.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1553.4999999999998, "alertThreshold": 2.0}]} 06:22:15 INFO - Return code: 0 06:22:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:22:15 INFO - # TBPL SUCCESS # 06:22:15 INFO - Running post-action listener: _resource_record_post_action 06:22:15 INFO - ##### 06:22:15 INFO - ##### Finished run-tests step (success) 06:22:15 INFO - ##### 06:22:15 INFO - Running post-run listener: _resource_record_post_run 06:22:15 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545615872; Read time: 12; Write time: 456632 06:22:15 INFO - TinderboxPrint: CPU usage
13.2% 06:22:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:22:15 INFO - TinderboxPrint: I/O write bytes / time
545,615,872 / 456,632 06:22:15 INFO - TinderboxPrint: CPU idle
8,327.2 (86.8%) 06:22:15 INFO - TinderboxPrint: CPU user
1,217.1 (12.7%) 06:22:15 INFO - TinderboxPrint: Swap in / out
0 / 0 06:22:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 246247424; Read time: 0; Write time: 209652 06:22:15 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299368448; Read time: 12; Write time: 246980 06:22:15 INFO - Running post-run listener: _upload_blobber_files 06:22:15 INFO - Blob upload gear active. 06:22:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:22:15 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 06:22:15 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:22:15 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:22:16 INFO - (blobuploader) - INFO - Open directory for files ... 06:22:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:22:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:19 INFO - (blobuploader) - INFO - Done attempting. 06:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:22:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:20 INFO - (blobuploader) - INFO - Done attempting. 06:22:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:22:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:22:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:20 INFO - (blobuploader) - INFO - Done attempting. 06:22:20 INFO - (blobuploader) - INFO - Iteration through files over. 06:22:20 INFO - Return code: 0 06:22:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:22:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:22:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c8d33a8ea4c067a4c0b2934e2a803c113a39a09277beb157cd93991e2861a2e2dde482a6c65841f251d9d2850bcbd2cebca458d7ebdb6caf78055cdcab569e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3fc65f2739f9ed709d4fc9e5637b08c875cdca56e3f8f369a0a7e27d48bfe158ef34f5b32642f7cda8e8f5ef546e68b3becfd48013f82e748eda5cf0b1b288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab9e7d3a3d4b5ec4210648e6dd4d8a5f00957ae514436767a7878967654c6aaff1de9e56fcb1330186177e462843292b1fe70e903af7b1c3a5e67a536ba2f9f6"} 06:22:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:22:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:22:20 INFO - Contents: 06:22:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c8d33a8ea4c067a4c0b2934e2a803c113a39a09277beb157cd93991e2861a2e2dde482a6c65841f251d9d2850bcbd2cebca458d7ebdb6caf78055cdcab569e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3fc65f2739f9ed709d4fc9e5637b08c875cdca56e3f8f369a0a7e27d48bfe158ef34f5b32642f7cda8e8f5ef546e68b3becfd48013f82e748eda5cf0b1b288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab9e7d3a3d4b5ec4210648e6dd4d8a5f00957ae514436767a7878967654c6aaff1de9e56fcb1330186177e462843292b1fe70e903af7b1c3a5e67a536ba2f9f6"} 06:22:20 INFO - Running post-run listener: copy_logs_to_upload_dir 06:22:20 INFO - Copying logs to upload dir... 06:22:20 INFO - mkdir: /builds/slave/test/build/upload/logs 06:22:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.018856 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-22 06:22:19.896218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:22:19.899454) ========= 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=523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c8d33a8ea4c067a4c0b2934e2a803c113a39a09277beb157cd93991e2861a2e2dde482a6c65841f251d9d2850bcbd2cebca458d7ebdb6caf78055cdcab569e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3fc65f2739f9ed709d4fc9e5637b08c875cdca56e3f8f369a0a7e27d48bfe158ef34f5b32642f7cda8e8f5ef546e68b3becfd48013f82e748eda5cf0b1b288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab9e7d3a3d4b5ec4210648e6dd4d8a5f00957ae514436767a7878967654c6aaff1de9e56fcb1330186177e462843292b1fe70e903af7b1c3a5e67a536ba2f9f6"} build_url:https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/JI1wp86uSn-S2f41_Xy-qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c8d33a8ea4c067a4c0b2934e2a803c113a39a09277beb157cd93991e2861a2e2dde482a6c65841f251d9d2850bcbd2cebca458d7ebdb6caf78055cdcab569e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3fc65f2739f9ed709d4fc9e5637b08c875cdca56e3f8f369a0a7e27d48bfe158ef34f5b32642f7cda8e8f5ef546e68b3becfd48013f82e748eda5cf0b1b288c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab9e7d3a3d4b5ec4210648e6dd4d8a5f00957ae514436767a7878967654c6aaff1de9e56fcb1330186177e462843292b1fe70e903af7b1c3a5e67a536ba2f9f6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:22:19.925277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:22:19.925581) ========= 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=523ca41ca1e0623de333ad52000001bf-1466600496.172210-423390524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:22:20.009971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:22:20.010309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:22:20.010605) ========= ========= Total master_lag: 0.24 =========