builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1465973139.63 results: success (0) buildid: 20160614222726 builduid: 3ac7aae7fd59489aa386a61d9fa451ca revision: da53037ac8087280b90ee94a55f116a24e5e9730 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:39.628779) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:39.629186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:39.629477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.009467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.009725) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 23:45:40-- 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% 79.3M=0s 2016-06-14 23:45:40 (79.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.144840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.145168) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021492 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:40.194938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 23:45:40.195244) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev da53037ac8087280b90ee94a55f116a24e5e9730 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev da53037ac8087280b90ee94a55f116a24e5e9730 --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=03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 23:45:40,631 truncating revision to first 12 chars 2016-06-14 23:45:40,631 Setting DEBUG logging. 2016-06-14 23:45:40,631 attempt 1/10 2016-06-14 23:45:40,631 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/da53037ac808?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 23:45:41,407 unpacking tar archive at: fx-team-da53037ac808/testing/mozharness/ program finished with exit code 0 elapsedTime=1.113595 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 23:45:41.324535) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.325107) ========= script_repo_revision: da53037ac8087280b90ee94a55f116a24e5e9730 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.325601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.325918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:45:41.339643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-14 23:45:41.340082) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:45:41 INFO - MultiFileLogger online at 20160614 23:45:41 in /builds/slave/test 23:45:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 23:45:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:45:41 INFO - {'append_to_log': False, 23:45:41 INFO - 'base_work_dir': '/builds/slave/test', 23:45:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:45:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:45:41 INFO - 'branch': 'Fx-Team-Non-PGO', 23:45:41 INFO - 'buildbot_json_path': 'buildprops.json', 23:45:41 INFO - 'config_files': ('talos/linux_config.py',), 23:45:41 INFO - 'default_actions': ('clobber', 23:45:41 INFO - 'read-buildbot-config', 23:45:41 INFO - 'download-and-extract', 23:45:41 INFO - 'populate-webroot', 23:45:41 INFO - 'create-virtualenv', 23:45:41 INFO - 'install', 23:45:41 INFO - 'run-tests'), 23:45:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:45:41 INFO - 'download_minidump_stackwalk': True, 23:45:41 INFO - 'download_symbols': 'ondemand', 23:45:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:45:41 INFO - 'tooltool.py': '/tools/tooltool.py', 23:45:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:45:41 INFO - '/tools/misc-python/virtualenv.py')}, 23:45:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:45:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:45:41 INFO - 'installer_path': 'installer.exe', 23:45:41 INFO - 'log_level': 'info', 23:45:41 INFO - 'log_name': 'talos', 23:45:41 INFO - 'log_to_console': True, 23:45:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:45:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:45:41 INFO - 'opt_config_files': (), 23:45:41 INFO - 'pip_index': False, 23:45:41 INFO - 'sps_profile': False, 23:45:41 INFO - 'sps_profile_interval': 0, 23:45:41 INFO - 'suite': 'dromaeojs', 23:45:41 INFO - 'system_bits': '32', 23:45:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:45:41 INFO - 'title': 'talos-linux64-ix-047', 23:45:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:45:41 INFO - 'use_talos_json': True, 23:45:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:45:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:45:41 INFO - 'work_dir': 'build'} 23:45:41 INFO - ##### 23:45:41 INFO - ##### Running clobber step. 23:45:41 INFO - ##### 23:45:41 INFO - Running pre-action listener: _resource_record_pre_action 23:45:41 INFO - Running main action method: clobber 23:45:41 INFO - rmtree: /builds/slave/test/build 23:45:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:45:42 INFO - Running post-action listener: _resource_record_post_action 23:45:42 INFO - ##### 23:45:42 INFO - ##### Finished clobber step (success) 23:45:42 INFO - ##### 23:45:42 INFO - ##### 23:45:42 INFO - ##### Running read-buildbot-config step. 23:45:42 INFO - ##### 23:45:42 INFO - Running pre-action listener: _resource_record_pre_action 23:45:42 INFO - Running main action method: read_buildbot_config 23:45:42 INFO - Using buildbot properties: 23:45:42 INFO - { 23:45:42 INFO - "project": "", 23:45:42 INFO - "product": "firefox", 23:45:42 INFO - "script_repo_revision": "production", 23:45:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:45:42 INFO - "repository": "", 23:45:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 23:45:42 INFO - "buildid": "20160614222726", 23:45:42 INFO - "pgo_build": "False", 23:45:42 INFO - "basedir": "/builds/slave/test", 23:45:42 INFO - "buildnumber": 3088, 23:45:42 INFO - "slavename": "talos-linux64-ix-047", 23:45:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:45:42 INFO - "platform": "ubuntu64_hw", 23:45:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:45:42 INFO - "branch": "fx-team", 23:45:42 INFO - "repo_path": "integration/fx-team", 23:45:42 INFO - "revision": "da53037ac8087280b90ee94a55f116a24e5e9730", 23:45:42 INFO - "stage_platform": "linux64", 23:45:42 INFO - "builduid": "3ac7aae7fd59489aa386a61d9fa451ca", 23:45:42 INFO - "slavebuilddir": "test" 23:45:42 INFO - } 23:45:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:45:42 INFO - Running post-action listener: _resource_record_post_action 23:45:42 INFO - ##### 23:45:42 INFO - ##### Finished read-buildbot-config step (success) 23:45:42 INFO - ##### 23:45:42 INFO - ##### 23:45:42 INFO - ##### Running download-and-extract step. 23:45:42 INFO - ##### 23:45:42 INFO - Running pre-action listener: _resource_record_pre_action 23:45:42 INFO - Running main action method: download_and_extract 23:45:42 INFO - mkdir: /builds/slave/test/build/tests 23:45:42 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')]} 23:45:42 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:45:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:45:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:45:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:50 INFO - Downloaded 1361 bytes. 23:45:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:45:50 INFO - Using the following test package requirements: 23:45:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:45:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:45:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:45:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'jsshell-linux-x86_64.zip'], 23:45:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:45:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:45:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:45:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:45:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:45:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:45:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:45:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:45: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')]} 23:45:50 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:45:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:45:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:45:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:03 INFO - Downloaded 22654307 bytes. 23:46:03 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'] 23:46:03 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 23:46:04 INFO - Return code: 0 23:46:04 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 23:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:04 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:46:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:46:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:46:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:05 INFO - Downloaded 22654307 bytes. 23:46:05 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'] 23:46:05 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 23:46:07 INFO - Return code: 0 23:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:07 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:46:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:46:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:46:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:08 INFO - Downloaded 14405384 bytes. 23:46:08 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'] 23:46:08 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 23:46:08 INFO - Return code: 0 23:46:08 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')]} 23:46:08 INFO - https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:46:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1JSttAGSgiuAqATgCaYoA/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 23:46:09 INFO - Downloaded 55425623 bytes. 23:46:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:09 INFO - mkdir: /builds/slave/test/properties 23:46:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:46:09 INFO - Writing to file /builds/slave/test/properties/build_url 23:46:09 INFO - Contents: 23:46:09 INFO - build_url:https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:46:10 INFO - Running post-action listener: _resource_record_post_action 23:46:10 INFO - Running post-action listener: set_extra_try_arguments 23:46:10 INFO - ##### 23:46:10 INFO - ##### Finished download-and-extract step (success) 23:46:10 INFO - ##### 23:46:10 INFO - ##### 23:46:10 INFO - ##### Running populate-webroot step. 23:46:10 INFO - ##### 23:46:10 INFO - Running pre-action listener: _resource_record_pre_action 23:46:10 INFO - Running main action method: populate_webroot 23:46:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:46:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:46:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:46:10 INFO - '--tppagecycles', 23:46:10 INFO - '7'], 23:46:10 INFO - 'tests': ['tsvgm']}}, 23:46:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:46:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:46:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:46:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:46:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['damp', 'tps']}, 23:46:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'tests': ['damp', 'tps']}, 23:46:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['dromaeo_dom']}, 23:46:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:46:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['basic_compositor_video']}, 23:46:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:46:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['a11yr', 23:46:10 INFO - 'ts_paint', 23:46:10 INFO - 'tpaint', 23:46:10 INFO - 'sessionrestore', 23:46:10 INFO - 'sessionrestore_no_auto_restore', 23:46:10 INFO - 'tabpaint']}, 23:46:10 INFO - 'other-e10s': {'tests': ['a11yr', 23:46:10 INFO - 'ts_paint', 23:46:10 INFO - 'tpaint', 23:46:10 INFO - 'sessionrestore', 23:46:10 INFO - 'sessionrestore_no_auto_restore', 23:46:10 INFO - 'tabpaint']}, 23:46:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:46:10 INFO - 'ts_paint', 23:46:10 INFO - 'tpaint', 23:46:10 INFO - 'sessionrestore', 23:46:10 INFO - 'sessionrestore_no_auto_restore', 23:46:10 INFO - 'tabpaint']}, 23:46:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:46:10 INFO - 'ts_paint', 23:46:10 INFO - 'tpaint', 23:46:10 INFO - 'sessionrestore', 23:46:10 INFO - 'sessionrestore_no_auto_restore', 23:46:10 INFO - 'tabpaint']}, 23:46:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['a11yr', 23:46:10 INFO - 'ts_paint', 23:46:10 INFO - 'tpaint', 23:46:10 INFO - 'sessionrestore', 23:46:10 INFO - 'sessionrestore_no_auto_restore', 23:46:10 INFO - 'tabpaint']}, 23:46:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['a11yr', 23:46:10 INFO - 'ts_paint', 23:46:10 INFO - 'tpaint', 23:46:10 INFO - 'sessionrestore', 23:46:10 INFO - 'sessionrestore_no_auto_restore', 23:46:10 INFO - 'tabpaint']}, 23:46:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['tsvgx', 23:46:10 INFO - 'tsvgr_opacity', 23:46:10 INFO - 'tart', 23:46:10 INFO - 'tscrollx', 23:46:10 INFO - 'cart']}, 23:46:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:46:10 INFO - 'tsvgr_opacity', 23:46:10 INFO - 'tart', 23:46:10 INFO - 'tscrollx', 23:46:10 INFO - 'cart']}, 23:46:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'talos_options': ['--disable-e10s'], 23:46:10 INFO - 'tests': ['tp5o']}, 23:46:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'tests': ['tp5o']}, 23:46:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'talos_options': ['--disable-e10s', 23:46:10 INFO - '--xperf_path', 23:46:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:10 INFO - 'tests': ['tp5n']}, 23:46:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:46:10 INFO - 'talos_options': ['--xperf_path', 23:46:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:10 INFO - 'tests': ['tp5n']}}, 23:46:10 INFO - 'talos.zip': {'path': '', 23:46:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:46:10 INFO - Running post-action listener: _resource_record_post_action 23:46:10 INFO - ##### 23:46:10 INFO - ##### Finished populate-webroot step (success) 23:46:10 INFO - ##### 23:46:10 INFO - ##### 23:46:10 INFO - ##### Running create-virtualenv step. 23:46:10 INFO - ##### 23:46:10 INFO - Running pre-action listener: _resource_record_pre_action 23:46:10 INFO - Running main action method: create_virtualenv 23:46:10 INFO - Creating virtualenv /builds/slave/test/build/venv 23:46:10 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 23:46:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:46:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:46:10 INFO - Using real prefix '/usr' 23:46:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:46:11 INFO - Installing distribute.............................................................................................................................................................................................done. 23:46:13 INFO - Installing pip.................done. 23:46:13 INFO - Return code: 0 23:46:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:46:13 INFO - Using env: {'DISPLAY': ':0', 23:46:13 INFO - 'HOME': '/home/cltbld', 23:46:13 INFO - 'LANG': 'en_US.UTF-8', 23:46:13 INFO - 'LANGUAGE': 'en_US:en', 23:46:13 INFO - 'LOGNAME': 'cltbld', 23:46:13 INFO - 'MAIL': '/var/mail/cltbld', 23:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:13 INFO - 'MOZ_NO_REMOTE': '1', 23:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:13 INFO - 'NO_EM_RESTART': '1', 23:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:13 INFO - 'PWD': '/builds/slave/test', 23:46:13 INFO - 'SHELL': '/bin/bash', 23:46:13 INFO - 'SHLVL': '1', 23:46:13 INFO - 'TERM': 'linux', 23:46:13 INFO - 'TMOUT': '86400', 23:46:13 INFO - 'USER': 'cltbld', 23:46:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:13 INFO - '_': '/tools/buildbot/bin/python'} 23:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:13 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 23:46:13 INFO - Cleaning up... 23:46:13 INFO - Return code: 0 23:46:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:46:13 INFO - Using env: {'DISPLAY': ':0', 23:46:13 INFO - 'HOME': '/home/cltbld', 23:46:13 INFO - 'LANG': 'en_US.UTF-8', 23:46:13 INFO - 'LANGUAGE': 'en_US:en', 23:46:13 INFO - 'LOGNAME': 'cltbld', 23:46:13 INFO - 'MAIL': '/var/mail/cltbld', 23:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:13 INFO - 'MOZ_NO_REMOTE': '1', 23:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:13 INFO - 'NO_EM_RESTART': '1', 23:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:13 INFO - 'PWD': '/builds/slave/test', 23:46:13 INFO - 'SHELL': '/bin/bash', 23:46:13 INFO - 'SHLVL': '1', 23:46:13 INFO - 'TERM': 'linux', 23:46:13 INFO - 'TMOUT': '86400', 23:46:13 INFO - 'USER': 'cltbld', 23:46:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:13 INFO - '_': '/tools/buildbot/bin/python'} 23:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:13 INFO - Downloading/unpacking psutil>=3.1.1 23:46:13 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 23:46:13 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 23:46:13 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 23:46:13 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 23:46:13 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 23:46:13 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 23:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:46:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:15 INFO - Installing collected packages: psutil 23:46:15 INFO - Running setup.py install for psutil 23:46:15 INFO - building 'psutil._psutil_linux' extension 23:46:15 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 23:46:15 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 23:46:15 INFO - building 'psutil._psutil_posix' extension 23:46:15 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 23:46:16 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 23:46:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:16 INFO - Successfully installed psutil 23:46:16 INFO - Cleaning up... 23:46:16 INFO - Return code: 0 23:46:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:46:16 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')]} 23:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:16 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')]} 23:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:16 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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:16 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 23:46:16 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 23:46:16 INFO - Using env: {'DISPLAY': ':0', 23:46:16 INFO - 'HOME': '/home/cltbld', 23:46:16 INFO - 'LANG': 'en_US.UTF-8', 23:46:16 INFO - 'LANGUAGE': 'en_US:en', 23:46:16 INFO - 'LOGNAME': 'cltbld', 23:46:16 INFO - 'MAIL': '/var/mail/cltbld', 23:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:16 INFO - 'MOZ_NO_REMOTE': '1', 23:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:16 INFO - 'NO_EM_RESTART': '1', 23:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:16 INFO - 'PWD': '/builds/slave/test', 23:46:16 INFO - 'SHELL': '/bin/bash', 23:46:16 INFO - 'SHLVL': '1', 23:46:16 INFO - 'TERM': 'linux', 23:46:16 INFO - 'TMOUT': '86400', 23:46:16 INFO - 'USER': 'cltbld', 23:46:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:16 INFO - '_': '/tools/buildbot/bin/python'} 23:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:46:18 INFO - Installing collected packages: mozsystemmonitor 23:46:18 INFO - Running setup.py install for mozsystemmonitor 23:46:18 INFO - Successfully installed mozsystemmonitor 23:46:18 INFO - Cleaning up... 23:46:18 INFO - Return code: 0 23:46:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:46:18 INFO - Using env: {'DISPLAY': ':0', 23:46:18 INFO - 'HOME': '/home/cltbld', 23:46:18 INFO - 'LANG': 'en_US.UTF-8', 23:46:18 INFO - 'LANGUAGE': 'en_US:en', 23:46:18 INFO - 'LOGNAME': 'cltbld', 23:46:18 INFO - 'MAIL': '/var/mail/cltbld', 23:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:18 INFO - 'MOZ_NO_REMOTE': '1', 23:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:18 INFO - 'NO_EM_RESTART': '1', 23:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:18 INFO - 'PWD': '/builds/slave/test', 23:46:18 INFO - 'SHELL': '/bin/bash', 23:46:18 INFO - 'SHLVL': '1', 23:46:18 INFO - 'TERM': 'linux', 23:46:18 INFO - 'TMOUT': '86400', 23:46:18 INFO - 'USER': 'cltbld', 23:46:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:18 INFO - '_': '/tools/buildbot/bin/python'} 23:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:18 INFO - Downloading/unpacking jsonschema==2.5.1 23:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:46:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:46:20 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 23:46:20 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 23:46:20 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 23:46:20 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 23:46:20 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 23:46:20 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 23:46:20 INFO - Downloading functools32-3.2.3-2.tar.gz 23:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:46:20 INFO - warning: no files found matching '*.txt' 23:46:20 INFO - no previously-included directories found matching 'build' 23:46:20 INFO - no previously-included directories found matching 'dist' 23:46:20 INFO - no previously-included directories found matching '.git*' 23:46:20 INFO - Installing collected packages: jsonschema, functools32 23:46:20 INFO - Running setup.py install for functools32 23:46:21 INFO - warning: no files found matching '*.txt' 23:46:21 INFO - no previously-included directories found matching 'build' 23:46:21 INFO - no previously-included directories found matching 'dist' 23:46:21 INFO - no previously-included directories found matching '.git*' 23:46:21 INFO - Successfully installed jsonschema functools32 23:46:21 INFO - Cleaning up... 23:46:21 INFO - Return code: 0 23:46:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:46:21 INFO - Using env: {'DISPLAY': ':0', 23:46:21 INFO - 'HOME': '/home/cltbld', 23:46:21 INFO - 'LANG': 'en_US.UTF-8', 23:46:21 INFO - 'LANGUAGE': 'en_US:en', 23:46:21 INFO - 'LOGNAME': 'cltbld', 23:46:21 INFO - 'MAIL': '/var/mail/cltbld', 23:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:21 INFO - 'MOZ_NO_REMOTE': '1', 23:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:21 INFO - 'NO_EM_RESTART': '1', 23:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:21 INFO - 'PWD': '/builds/slave/test', 23:46:21 INFO - 'SHELL': '/bin/bash', 23:46:21 INFO - 'SHLVL': '1', 23:46:21 INFO - 'TERM': 'linux', 23:46:21 INFO - 'TMOUT': '86400', 23:46:21 INFO - 'USER': 'cltbld', 23:46:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:21 INFO - '_': '/tools/buildbot/bin/python'} 23:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:21 INFO - Downloading/unpacking blobuploader==1.2.4 23:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:23 INFO - Downloading blobuploader-1.2.4.tar.gz 23:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:46:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:46:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:23 INFO - Downloading docopt-0.6.1.tar.gz 23:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:46:23 INFO - Installing collected packages: blobuploader, requests, docopt 23:46:23 INFO - Running setup.py install for blobuploader 23:46:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:46:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:46:24 INFO - Running setup.py install for requests 23:46:24 INFO - Running setup.py install for docopt 23:46:24 INFO - Successfully installed blobuploader requests docopt 23:46:24 INFO - Cleaning up... 23:46:24 INFO - Return code: 0 23:46:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:24 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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:24 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 23:46:24 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 23:46:24 INFO - Using env: {'DISPLAY': ':0', 23:46:24 INFO - 'HOME': '/home/cltbld', 23:46:24 INFO - 'LANG': 'en_US.UTF-8', 23:46:24 INFO - 'LANGUAGE': 'en_US:en', 23:46:24 INFO - 'LOGNAME': 'cltbld', 23:46:24 INFO - 'MAIL': '/var/mail/cltbld', 23:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:24 INFO - 'MOZ_NO_REMOTE': '1', 23:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:24 INFO - 'NO_EM_RESTART': '1', 23:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:24 INFO - 'PWD': '/builds/slave/test', 23:46:24 INFO - 'SHELL': '/bin/bash', 23:46:24 INFO - 'SHLVL': '1', 23:46:24 INFO - 'TERM': 'linux', 23:46:24 INFO - 'TMOUT': '86400', 23:46:24 INFO - 'USER': 'cltbld', 23:46:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:24 INFO - '_': '/tools/buildbot/bin/python'} 23:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:24 INFO - Running setup.py (path:/tmp/pip-R4sZ2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:24 INFO - Running setup.py (path:/tmp/pip-Go3OXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:24 INFO - Running setup.py (path:/tmp/pip-1DCE6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:24 INFO - Running setup.py (path:/tmp/pip-BsUDQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:25 INFO - Running setup.py (path:/tmp/pip-NPamVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:25 INFO - Running setup.py (path:/tmp/pip-qjcny3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:25 INFO - Running setup.py (path:/tmp/pip-10t15A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:25 INFO - Running setup.py (path:/tmp/pip-uiIIWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:25 INFO - Running setup.py (path:/tmp/pip-Waw3LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:25 INFO - Running setup.py (path:/tmp/pip-OVFvQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:25 INFO - Running setup.py (path:/tmp/pip-jBsNVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:25 INFO - Running setup.py (path:/tmp/pip-KXUFEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:25 INFO - Running setup.py (path:/tmp/pip-57IGdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:25 INFO - Running setup.py (path:/tmp/pip-rVaspT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:25 INFO - Running setup.py (path:/tmp/pip-uScuy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:25 INFO - Running setup.py (path:/tmp/pip-e3BbWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:25 INFO - Running setup.py (path:/tmp/pip-AubQrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:46:25 INFO - Running setup.py install for manifestparser 23:46:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Running setup.py install for mozcrash 23:46:26 INFO - Running setup.py install for mozdebug 23:46:26 INFO - Running setup.py install for mozdevice 23:46:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Running setup.py install for mozfile 23:46:26 INFO - Running setup.py install for mozhttpd 23:46:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Running setup.py install for mozinfo 23:46:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Running setup.py install for mozInstall 23:46:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:46:26 INFO - Running setup.py install for mozleak 23:46:26 INFO - Running setup.py install for mozlog 23:46:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:46:27 INFO - Running setup.py install for moznetwork 23:46:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:46:27 INFO - Running setup.py install for mozprocess 23:46:27 INFO - Running setup.py install for mozprofile 23:46:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:46:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:46:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:46:27 INFO - Running setup.py install for mozrunner 23:46:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:46:27 INFO - Running setup.py install for mozscreenshot 23:46:27 INFO - Running setup.py install for moztest 23:46:27 INFO - Running setup.py install for mozversion 23:46:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:46:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:46:27 INFO - Cleaning up... 23:46:27 INFO - Return code: 0 23:46:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:27 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')]} 23:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:27 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')]} 23:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:27 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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:27 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 23:46:27 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 23:46:27 INFO - Using env: {'DISPLAY': ':0', 23:46:27 INFO - 'HOME': '/home/cltbld', 23:46:27 INFO - 'LANG': 'en_US.UTF-8', 23:46:27 INFO - 'LANGUAGE': 'en_US:en', 23:46:27 INFO - 'LOGNAME': 'cltbld', 23:46:27 INFO - 'MAIL': '/var/mail/cltbld', 23:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:27 INFO - 'MOZ_NO_REMOTE': '1', 23:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:27 INFO - 'NO_EM_RESTART': '1', 23:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:27 INFO - 'PWD': '/builds/slave/test', 23:46:27 INFO - 'SHELL': '/bin/bash', 23:46:27 INFO - 'SHLVL': '1', 23:46:27 INFO - 'TERM': 'linux', 23:46:27 INFO - 'TMOUT': '86400', 23:46:27 INFO - 'USER': 'cltbld', 23:46:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:27 INFO - '_': '/tools/buildbot/bin/python'} 23:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:28 INFO - Running setup.py (path:/tmp/pip-PafDu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:28 INFO - Running setup.py (path:/tmp/pip-KXEOL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:28 INFO - Running setup.py (path:/tmp/pip-PL0fML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:28 INFO - Running setup.py (path:/tmp/pip-OWmD9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:28 INFO - Running setup.py (path:/tmp/pip-8vBUWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:28 INFO - Running setup.py (path:/tmp/pip-RWAXjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:28 INFO - Running setup.py (path:/tmp/pip-BuYksl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:28 INFO - Running setup.py (path:/tmp/pip-8tkohF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:28 INFO - Running setup.py (path:/tmp/pip-GaBtJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:28 INFO - Running setup.py (path:/tmp/pip-_bOLSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:28 INFO - Running setup.py (path:/tmp/pip-RUUlr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:28 INFO - Running setup.py (path:/tmp/pip-b58FOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:28 INFO - Running setup.py (path:/tmp/pip-vvPcI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:28 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)) 23:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:28 INFO - Running setup.py (path:/tmp/pip-mlmI9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:29 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)) 23:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:29 INFO - Running setup.py (path:/tmp/pip-5Lwv2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:29 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)) 23:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:29 INFO - Running setup.py (path:/tmp/pip-jXcbE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:29 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)) 23:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:29 INFO - Running setup.py (path:/tmp/pip-sIsjTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:29 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)) 23:46:29 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)) 23:46:29 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)) 23:46:29 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)) 23:46:29 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)) 23:46:29 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)) 23:46:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:46:29 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 23:46:29 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 23:46:29 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 23:46:29 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 23:46:29 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 23:46:29 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 23:46:31 INFO - Downloading blessings-1.6.tar.gz 23:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:46:31 INFO - Installing collected packages: blessings 23:46:31 INFO - Running setup.py install for blessings 23:46:31 INFO - Successfully installed blessings 23:46:31 INFO - Cleaning up... 23:46:31 INFO - Return code: 0 23:46:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:46:31 INFO - Reading from file tmpfile_stdout 23:46:31 INFO - Current package versions: 23:46:31 INFO - argparse == 1.2.1 23:46:31 INFO - blessings == 1.6 23:46:31 INFO - blobuploader == 1.2.4 23:46:31 INFO - docopt == 0.6.1 23:46:31 INFO - functools32 == 3.2.3-2 23:46:31 INFO - jsonschema == 2.5.1 23:46:31 INFO - manifestparser == 1.1 23:46:31 INFO - mozInstall == 1.12 23:46:31 INFO - mozcrash == 0.17 23:46:31 INFO - mozdebug == 0.1 23:46:31 INFO - mozdevice == 0.48 23:46:31 INFO - mozfile == 1.2 23:46:31 INFO - mozhttpd == 0.7 23:46:31 INFO - mozinfo == 0.9 23:46:31 INFO - mozleak == 0.1 23:46:31 INFO - mozlog == 3.2 23:46:31 INFO - moznetwork == 0.27 23:46:31 INFO - mozprocess == 0.22 23:46:31 INFO - mozprofile == 0.28 23:46:31 INFO - mozrunner == 6.11 23:46:31 INFO - mozscreenshot == 0.1 23:46:31 INFO - mozsystemmonitor == 0.3 23:46:31 INFO - moztest == 0.7 23:46:31 INFO - mozversion == 1.4 23:46:31 INFO - psutil == 3.1.1 23:46:31 INFO - requests == 1.2.3 23:46:31 INFO - wsgiref == 0.1.2 23:46:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:31 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')]} 23:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:31 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')]} 23:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:31 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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:31 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 23:46:31 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 23:46:31 INFO - Using env: {'DISPLAY': ':0', 23:46:31 INFO - 'HOME': '/home/cltbld', 23:46:31 INFO - 'LANG': 'en_US.UTF-8', 23:46:31 INFO - 'LANGUAGE': 'en_US:en', 23:46:31 INFO - 'LOGNAME': 'cltbld', 23:46:31 INFO - 'MAIL': '/var/mail/cltbld', 23:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:31 INFO - 'MOZ_NO_REMOTE': '1', 23:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:31 INFO - 'NO_EM_RESTART': '1', 23:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:31 INFO - 'PWD': '/builds/slave/test', 23:46:31 INFO - 'SHELL': '/bin/bash', 23:46:31 INFO - 'SHLVL': '1', 23:46:31 INFO - 'TERM': 'linux', 23:46:31 INFO - 'TMOUT': '86400', 23:46:31 INFO - 'USER': 'cltbld', 23:46:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:31 INFO - '_': '/tools/buildbot/bin/python'} 23:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 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)) 23:46:31 INFO - Cleaning up... 23:46:31 INFO - Return code: 0 23:46:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:46:31 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')]} 23:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:31 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')]} 23:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:31 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 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:31 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 23:46:31 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 23:46:31 INFO - Using env: {'DISPLAY': ':0', 23:46:31 INFO - 'HOME': '/home/cltbld', 23:46:31 INFO - 'LANG': 'en_US.UTF-8', 23:46:31 INFO - 'LANGUAGE': 'en_US:en', 23:46:31 INFO - 'LOGNAME': 'cltbld', 23:46:31 INFO - 'MAIL': '/var/mail/cltbld', 23:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:31 INFO - 'MOZ_NO_REMOTE': '1', 23:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:31 INFO - 'NO_EM_RESTART': '1', 23:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:31 INFO - 'PWD': '/builds/slave/test', 23:46:31 INFO - 'SHELL': '/bin/bash', 23:46:31 INFO - 'SHLVL': '1', 23:46:31 INFO - 'TERM': 'linux', 23:46:31 INFO - 'TMOUT': '86400', 23:46:31 INFO - 'USER': 'cltbld', 23:46:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:31 INFO - '_': '/tools/buildbot/bin/python'} 23:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:46:32 INFO - Cleaning up... 23:46:32 INFO - Return code: 0 23:46:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb109f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', '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 23:46:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:46:32 INFO - Using env: {'DISPLAY': ':0', 23:46:32 INFO - 'HOME': '/home/cltbld', 23:46:32 INFO - 'LANG': 'en_US.UTF-8', 23:46:32 INFO - 'LANGUAGE': 'en_US:en', 23:46:32 INFO - 'LOGNAME': 'cltbld', 23:46:32 INFO - 'MAIL': '/var/mail/cltbld', 23:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:32 INFO - 'MOZ_NO_REMOTE': '1', 23:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:32 INFO - 'NO_EM_RESTART': '1', 23:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:32 INFO - 'PWD': '/builds/slave/test', 23:46:32 INFO - 'SHELL': '/bin/bash', 23:46:32 INFO - 'SHLVL': '1', 23:46:32 INFO - 'TERM': 'linux', 23:46:32 INFO - 'TMOUT': '86400', 23:46:32 INFO - 'USER': 'cltbld', 23:46:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:32 INFO - '_': '/tools/buildbot/bin/python'} 23:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:32 INFO - Downloading/unpacking flake8 23:46:32 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 23:46:32 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 23:46:32 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 23:46:32 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 23:46:32 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 23:46:32 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 23:46:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:46:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:46:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:46:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:46:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:46:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:46:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:46:34 INFO - no previously-included directories found matching 'docs/_build' 23:46:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:46:34 INFO - Running setup.py install for pep8 23:46:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:46:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:46:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:46:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:46:34 INFO - no previously-included directories found matching 'docs/_build' 23:46:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:46:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:46:35 INFO - Cleaning up... 23:46:35 INFO - Return code: 0 23:46:35 INFO - Running post-action listener: _resource_record_post_action 23:46:35 INFO - Running post-action listener: _start_resource_monitoring 23:46:35 INFO - Starting resource monitoring. 23:46:35 INFO - ##### 23:46:35 INFO - ##### Finished create-virtualenv step (success) 23:46:35 INFO - ##### 23:46:35 INFO - ##### 23:46:35 INFO - ##### Running install step. 23:46:35 INFO - ##### 23:46:35 INFO - Running pre-action listener: _resource_record_pre_action 23:46:35 INFO - Running main action method: install 23:46:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:46:35 INFO - Reading from file tmpfile_stdout 23:46:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:46:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:46:35 INFO - Reading from file tmpfile_stdout 23:46:35 INFO - Output received: 23:46:35 INFO - Usage: mozinstall [options] installer 23:46:35 INFO - Options: 23:46:35 INFO - -h, --help show this help message and exit 23:46:35 INFO - -d DEST, --destination=DEST 23:46:35 INFO - Directory to install application into. [default: 23:46:35 INFO - "/builds/slave/test"] 23:46:35 INFO - --app=APP Application being installed. [default: firefox] 23:46:35 INFO - mkdir: /builds/slave/test/build/application 23:46:35 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'] 23:46:35 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 23:46:51 INFO - Reading from file tmpfile_stdout 23:46:51 INFO - Output received: 23:46:51 INFO - /builds/slave/test/build/application/firefox/firefox 23:46:51 INFO - Running post-action listener: _resource_record_post_action 23:46:51 INFO - ##### 23:46:51 INFO - ##### Finished install step (success) 23:46:51 INFO - ##### 23:46:51 INFO - ##### 23:46:51 INFO - ##### Running run-tests step. 23:46:51 INFO - ##### 23:46:51 INFO - Running pre-action listener: _resource_record_pre_action 23:46:51 INFO - Running main action method: run_tests 23:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:46:51 INFO - Python 2.7.3 23:46:51 INFO - Return code: 0 23:46:51 INFO - grabbing minidump binary from tooltool 23:46: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')]} 23:46:51 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 0x21cb1c0>, '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 0x21cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:46:51 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 23:46:51 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 23:46:51 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 23:46:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:46:51 INFO - Return code: 0 23:46:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:46:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:46:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:46:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:46:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:46:52 INFO - Return code: 0 23:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 23:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 23:46:52 INFO - Using env: {'DISPLAY': ':0', 23:46:52 INFO - 'HOME': '/home/cltbld', 23:46:52 INFO - 'LANG': 'en_US.UTF-8', 23:46:52 INFO - 'LANGUAGE': 'en_US:en', 23:46:52 INFO - 'LOGNAME': 'cltbld', 23:46:52 INFO - 'MAIL': '/var/mail/cltbld', 23:46:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:46:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:52 INFO - 'MOZ_NO_REMOTE': '1', 23:46:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:52 INFO - 'NO_EM_RESTART': '1', 23:46:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:52 INFO - 'PWD': '/builds/slave/test', 23:46:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:46:52 INFO - 'SHELL': '/bin/bash', 23:46:52 INFO - 'SHLVL': '1', 23:46:52 INFO - 'TERM': 'linux', 23:46:52 INFO - 'TMOUT': '86400', 23:46:52 INFO - 'USER': 'cltbld', 23:46:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432', 23:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:52 INFO - '_': '/tools/buildbot/bin/python'} 23:46:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 23:46:52 INFO - mozversion application_buildid: 20160614222726 23:46:52 INFO - mozversion application_changeset: da53037ac8087280b90ee94a55f116a24e5e9730 23:46:52 INFO - mozversion application_display_name: Nightly 23:46:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:46:52 INFO - mozversion application_name: Firefox 23:46:52 INFO - mozversion application_remotingname: firefox 23:46:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:46:52 INFO - mozversion application_vendor: Mozilla 23:46:52 INFO - mozversion application_version: 50.0a1 23:46:52 INFO - mozversion platform_buildid: 20160614222726 23:46:52 INFO - mozversion platform_changeset: da53037ac8087280b90ee94a55f116a24e5e9730 23:46:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:46:52 INFO - mozversion platform_version: 50.0a1 23:46:52 INFO - using testdate: 1465973212 23:46:52 INFO - actual date: 1465973212 23:46:52 INFO - starting webserver on 'localhost:43857' 23:46:52 INFO - SUITE-START | Running 2 tests 23:46:52 INFO - TEST-START | dromaeo_css 23:46:52 INFO - operating with platform_type : linux_ 23:46:52 INFO - Initialising browser for dromaeo_css test... 23:46:52 INFO - TEST-INFO | started process 7056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuglnZn/profile http://localhost:43857/getInfo.html) 23:46:57 INFO - PROCESS | 7056 | __metrics Screen width/height:1600/1200 23:46:57 INFO - PROCESS | 7056 | colorDepth:24 23:46:57 INFO - PROCESS | 7056 | Browser inner width/height: 1024/697 23:46:57 INFO - PROCESS | 7056 | __metrics 23:46:58 INFO - PROCESS | 7056 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:46:58 INFO - PROCESS | 7056 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:46:58 INFO - PROCESS | 7056 | console.error: PushService: 23:46:58 INFO - PROCESS | 7056 | stateChangeProcessEnqueue: Error transitioning state 23:46:58 INFO - PROCESS | 7056 | UnknownError 23:46:59 INFO - TEST-INFO | 7056: exit 0 23:46:59 INFO - Browser initialized. 23:46:59 INFO - Running cycle 1/1 for dromaeo_css test... 23:46:59 INFO - TEST-INFO | started process 7135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuglnZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:47:11 INFO - PROCESS | 7135 | RSS: Main: 175886336 23:47:11 INFO - PROCESS | 7135 | 23:48:03 INFO - PROCESS | 7135 | 1465973283536 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] 23:50:15 INFO - PROCESS | 7135 | Cycle 1(1): loaded http://localhost:43857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43857/tests/dromaeo/cssquery-ext.html) 23:50:16 INFO - PROCESS | 7135 | RSS: Main: 288952320 23:50:16 INFO - PROCESS | 7135 | 23:53:19 INFO - PROCESS | 7135 | Cycle 1(1): loaded http://localhost:43857/tests/dromaeo/cssquery-ext.html (next: http://localhost:43857/tests/dromaeo/cssquery-jquery.html) 23:53:19 INFO - PROCESS | 7135 | RSS: Main: 261382144 23:53:19 INFO - PROCESS | 7135 | 23:56:22 INFO - PROCESS | 7135 | Cycle 1(1): loaded http://localhost:43857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43857/tests/dromaeo/cssquery-mootools.html) 23:56:22 INFO - PROCESS | 7135 | RSS: Main: 256094208 23:56:22 INFO - PROCESS | 7135 | 23:59:24 INFO - PROCESS | 7135 | Cycle 1(1): loaded http://localhost:43857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43857/tests/dromaeo/cssquery-prototype.html) 23:59:25 INFO - PROCESS | 7135 | RSS: Main: 257363968 23:59:25 INFO - PROCESS | 7135 | 00:02:28 INFO - PROCESS | 7135 | Cycle 1(1): loaded http://localhost:43857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43857/tests/dromaeo/cssquery-yui.html) 00:02:29 INFO - PROCESS | 7135 | RSS: Main: 228982784 00:02:29 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | Cycle 1(1): loaded http://localhost:43857/tests/dromaeo/cssquery-yui.html (next: http://localhost:43857/tests/dromaeo/cssquery-dojo.html) 00:05:32 INFO - PROCESS | 7135 | RSS: Main: 290324480 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | __start_tp_report 00:05:32 INFO - PROCESS | 7135 | _x_x_mozilla_page_load 00:05:32 INFO - PROCESS | 7135 | _x_x_mozilla_page_load_details 00:05:32 INFO - PROCESS | 7135 | |i|pagename|runs| 00:05:32 INFO - PROCESS | 7135 | |0;dojo.html;2561.500507401055;2594.6886373635166;2595.4290056187633;2597.5194589001035;2611.0469678567315;4577.153226653071;4640.6055485283705;4663.930041049387;4688.929666055008;4729.054189162164;4689.390379250693;4707.976460117703;4723.787429565669;4773.618110551148;4804.25534042224;4296.806643701041;4303.763293018883;4358.43340365752;4409.889752756175;4490.191765482212;4403.185410699015;4438.622717069037;4457.264551349023;4463.174312752135;4484.730916145026;4210.073783767566;4227.239096962546;4244.0663054128045;4260;4374.518802931675;4322.762248076355;4340.023494713696;4343.500497442771;4354.259775838115;4359.411479450266;4386.758728269944;4394.099209662011;4404.559544045602;4421.049474363027;4438.578335058164;4556.77216139195;4646.883827904296;4787.832425865078;4796.304535842318;4834.830780922686;5020.698758074527;5048.6465947383695;5095.541401273866;5109.923351149736;5114.923276150861;5059.089363914494;5103.004914041763;5105.336306280197;5113.51421614946;5123.590112791005;4616.815327386867;4660.231061874821;4692.4603670577635;4787;4788.61691064714;5106.463821298785;5107.846764597068;5143.151380022255;5152.124138896396;5163.3545806774155;4947.356843610308;4964.478729733398;4965.801367945314;4967.40391153064;4970.080535101018;4970.925436118461;4980.701157930535;5018.2974383586325;5055.16589762685;5079.263506791494;5054.898902021939;5060.49395060491;5064.442911279756;5088.745562721849;5096.770645320969;5023.14606516893;5042.773075211624;5042.848714538496;5048;5099.87250318745;4217.0511634881905;4266.0827921996915;4274.829006839754;4330.7401555906745;4375.256206444912;3736.981315093407;3760.4735337052834;3775.1317197044286;3800.923981520354;3857.787821669779;4354.8911277217685;4358.8038538265855;4368.344748287719;4410.20616289071;4410.316400957857;4964.801407943642;5011.523905228997;5036.11867923112;5101.9489805101475;5145.279660847485;4322.827086916488;4339.869803905888;4343.9348409773875;4374.19077470669;4384.101259241847;4548.135854187693;4558.384618076518;4561.178987782231;4561.429821272341;4603.056373443436;4608.446986361658;4727.3854398927915;4727.716337019721;4772.331873537638;4773.64197685182;5086.923696144635;5101.183810590288;5103.591712663052;5104.846854594368;5153.072446959433;4765.928511072406;4789.521047895182;4789.760511974457;4790.7365094920115;4826.300186473012;4845.9757701211265;4959.479254678206;4968.950310496849;4973;4987.2768448574025;5018.723970181529;5049.545540901337;5053.974730126326;5056.367954005749;5101.642884998015;4815.566599006106;4912.38595175603;4920.950790492192;4923.187674033888;4973.676711013773;4908.042931628298;4936.605071594336;4959.479254678206;4976.875578110431;4982.775775090202;4919.950800491949;4933.679310844784;4962.354893863919;4972.552470277692;4973.328600638867;4854.5873600744335;4935.407751069894;5016.924746128738;5064.442911279682;5073.239014147907;4701.482836888008;4720.716756994591;4740.905181896412;4803.903921921612;4878.243872199815 00:05:32 INFO - PROCESS | 7135 | |1;ext.html;533.8029077968414;576.6338375131791;590.6042951222678;590.6721769417973;592.3957563285446;27543.586846197322;38667.41998870016;39618;39618;43181.136377272516;40843.79578102113;41173;41222.58777412225;41224;41225;7565.773026809205;7832.255935686129;7982.560959147245;7986.640601172932;10121.746956326077;9853.113219810215;10228.74428139295;10241.436720980342;10253.17974562037;10255.179585633168;10239.488025598728;10279.537420816045;10295.897041029606;10299.588016479369;10303.896961030407;7633.351165150996;10078;10126.797464050715;10347.482625868677;10354.17166626668;9846.803063938753;10183.134433573156;10186.59253629854;10197.18422526196;10197.592096316139;38453;38986.41520377197;38993.41509877354;39060.41409378862;39183.41224881629;2953.4536110819568;3039;3054;3078.6921307869256;3219.985704503074;29613.70386296131;29943;30002.549961750592;30214;30597.847010765025;3288.3094550144497;3299.0597679661423;3342.8328583570724;3358.462645976632;3367.2760356523463;244307;245220;245322;245371;245896.99999999822;32450.83774581112;54977.45022549803;55286;55421;55440.72279638576;32918.506222406686;34714.479282810775;34770.30459390798;34789;34820.65179348225;13004;13336.866631333562;13437.462501499831;13458.865411345958;13464;9580.904190958001;10311.535980880879;10579.5239214234;10585.4707264638;10827.458627068616;8046.436749427484;8115.6753729851325;8158.877616835753;8194.180581941877;8209.220124088202;3227.386796508656;3245.8214798186327;3253.3655937092512;3253.3818574470774;3292.27569934614;843.4306842881031;847.872819077131;887.7691800132012;965.8068386322764;1033.2715435617872;27148.321291967462;27738.306542336602;27778.583321250197;28130.2967425816;28369.858150709115;968.138356862393;983.5573991703619;1009.9192064634811;1031.8555402243692;1111.6053800900725;14467.78298325526;14573;14810.481633142788;15111.622209444851;15171.393144274105;410785;415803;415907;416544;416742;50070.749646251534;50690;50724;50749.74625126851;50762.74618626957;1100.8513850630222;1133.7052366384635;1168.6961390038482;1185.1526158796503;1225.1913736933582;26473.33816654599;28814.135575932756;29050;29615.25961850971;29851.253718657208;42151.7892410536;42571.36142957796;42720;42805.35791963061;42932.57067429286;314055;316668;317567;317829;318943;22777.772222277566;25182;25817.6127358086;25962.312449691464;26219.344516387242;40778.18443631051;41331;41962.37056444095;42036.36945445882;42332.788336058125;35236.34621526726;35848.82075589606;35961.82019089888;36292.45561316635;36593.81703091467;35540.466892997145;35669.46495802513;35842.462363064056;35963.820180898925;36383.81808090943;34911.12722181966;35683.28633427265;35862.64137358593;36256.19309972415;36329.63670363368;31159;32474.512882306313;32679.18302042468;32680.50979235361;32972.340553188325;24768.380790480383;25220.747792522572;25334.792975721066;25355.492890141726;25392.365190870376 00:05:32 INFO - PROCESS | 7135 | |2;jquery.html;357.1963083063108;357.7209776374428;360.3423751653232;367.4433233651018;369.82802996606574;15847.603809904758;16987.320507179713;17476.82523174768;17826;17833.73249401257;16227.83772162278;16316.836831631681;17126.657466850655;17153.57116072099;17185.140742962834;5139.25480805283;5291.629585928987;5298.258243845846;5325.840224793243;5339.092354299759;3763.680087192592;5195.66228195168;5882.411758824126;6237.220347456568;6242.625442473443;6109.786157484489;6246.812595622116;6286.151369565118;6286.622802631834;6295;6094.60385074971;6212.037134244154;6214.223222097238;6224.719887605046;6225.7509699611965;3382;4943.579795717368;5297.682139071668;5301.204819277139;5377.11277639189;20177.8991105045;20899.68650470244;20904.686429703568;21234.8147777833;21236.36290911275;1952.9804701952942;2082.6147162774937;2142.8500004999655;2177.684235785818;2194.5501172259646;13128.212307261594;13207.141535800141;13289.20264784116;13425.462981480729;13557.864421355758;1750.1074452029557;1801.7837859456818;1832.4502649205185;1846.26149540185;1849.2880241107136;60936.39063609396;63209.99999999954;64079;64489;64577;9285.117913798178;9312.161905428544;9427.19868811145;9627.277954153467;9890.060444257784;12553.874461255271;12561.685957850945;12673.17624354414;12685.73142685724;12694.555690550786;7123.465740069516;7188.604626745475;7287.234840341794;7333.230010848891;7368.226336234726;7078.823029424306;7088.503804733722;7119.501634885612;7253.1296244451005;7267.854642907112;6073.787417440369;6151;6168.907466388007;6200.131981522591;6222.377762223741;1544.6987837371605;1640.261882153036;1648.777415048977;1714.3399791080274;1755.3768412213735;363.08864749479;366.948627192188;389.7583498231115;856.1438561438562;857.3269983063266;9903.7028889132;10345.224108191916;10429.634962776267;10481.580736770597;10964.56141754321;404.26222144586245;404.61561516559385;404.62976376615654;414.40532835380725;420.74334655860514;5633.887322253532;5726.484616384545;5763.538916886639;5774.364819869811;5784.421557844266;371509;380022;380859;384780;393627;81011;84292;84477;84538.57730711307;84634.5768271167;418.6964450773165;427.42084475535825;428.8734823227093;429.2830972276306;430.2234466787416;9352.158305752515;9870;9998.150157236716;10018.39889606626;10166.796664066826;36899.26201476009;37408.251834963696;37986.810065949496;39294.607053929096;39379.4248230079;47788.7610561945;49572.25641615451;54308;54729.1790623133;55324.72337638447;7431;7727.459077864721;7773.144954055162;7821.843563128592;7849.725259615886;10810.621628242974;11643.243189192675;11792.351420671945;11806.586769463027;11811.586594469496;9813.656522021694;9833.5083245836;10025.548850301608;10056.446895420822;10138.695839124837;10281.2803103785;10322.48387580633;10388.48057597102;10478.58085676595;10619.203559732896;10020.549075291776;10112.089911907964;10129.544170512492;10302.639407620698;10639.8936010642;7414.518056326321;7622.961885190539;7798.025246844145;7800.180980996914;8028.157043510348;9861.112499875046;9880.160186384237;10007.399556026661;10361.533730982275;10732.356058636507 00:05:32 INFO - PROCESS | 7135 | |3;mootools.html;1188.4057971014493;1363.297901580686;1390.1867407566574;1465.325950062971;1677.8573821225195;6581.7696380626685;7304.780856574304;7565.735199268027;7578.96210518948;7726.42051846111;7403.2226616205335;7482.064741907262;7500.774976750707;7515.699372025112;7519.962400187991;1867.7758668959675;1912.5887934094167;1915.6647586672345;2195.407240045191;2224.077008041661;1954.6286205620959;2156.751973523041;2246.9438264043365;2247;2265.716785401825;2160.2655097266925;2167.0464995402053;2169.349195241421;2177.7495588007423;2179.8147157491553;1852.2776117314258;2138.828893688501;2144.839137064711;2147.6134295826746;2148.9247876324253;2063.484128967758;2142.0574947023415;2146.667266573668;2147.978520214809;2154.6875703022974;7535.849283014364;7595.772126836204;7603.0876294844975;7607.771766847003;7612.1246056703085;4460.4647442306805;4592.1045396147765;4592.563706447882;4592.862214133548;4593.609543188833;2749.4913441013477;2777.9444411111867;2820.182147177316;2880.7839412043973;2885.0623547347195;877.666486735043;895.6417433026776;901.2159421303443;909.6497848328441;915.5102020419043;10152.746181345452;10215.182785377152;10218.744531386776;10221.79556408875;10234.334768240114;4109.506859176918;4148.979255103705;4222.767747773902;4248.660107191417;4257.340112282601;8729.388942773945;8772.34207434445;8777.91222087771;8781.209691127702;8793.956030219808;4638.907221855544;4646;4653.53464653532;4653.767311634405;4655.580997710154;3599.892003239907;3635.5273814404486;4122.835086596562;4224.55642157569;4227.429297044921;3521.4013617685055;3568.4825700273313;3670.100825297819;3676.3933950897804;3697.0387699198404;1134.5915470430639;1189.7323102302087;1199.8800119987932;1202.0864143251017;1209.4013463335705;659.6306068601599;721.7257442171941;757.8749506331394;787.8857565652949;796.7092011415791;4805.303231031481;4829.396325459317;4855.975720121377;4856;4956.727379994135;393.20572443664213;401.46204086523613;408.33033824527797;414.68691138190474;415.198666573516;3633.4913112164318;3753.943690844585;3829.751066180689;3918.8236529356245;3934.842606295716;9087.772805679911;9100.8634870477;9149.40528865635;9208.217301529312;9289.349745517884;9016.233620142362;9034.86447703285;9046.05016473274;9047.095290471032;9169.541522923828;7079.575225486487;7170.784876453715;7321.524100933529;7325.04774379338;7329.9267007329245;5272.077386457431;5284.339457567804;5310.867228319168;5379.946200537945;5433.157860531624;8803.735887923373;8928.241099506615;9026.909730902607;9032.096790321179;9042.683506077256;8083.312918402002;8435.83128337442;8450.408471406943;8667.17661822126;9053.139951704577;5926.259217597801;6083.178770866053;6085.513158947362;6574.539782215199;6714.966425168039;6619.867602648016;6663.766768163091;6780.32196780318;6960.547564408297;6983.825404364931;6417.358264173732;6437.581557198767;6488.480921526361;6495.805125846232;6549.901751473636;6354.586951848115;6422.743090276524;6469.5794773339585;6505.73977040932;6526.184226971629;6042.123892035718;6130.295016073031;6147.508199343953;6198.411150940653;6198.907016394848;4026.3960405939342;4037.7577345359373;4079.4696689430184;4091.0999580092334;4123.505179378494;4106.3635136553885;4149.585041495826;4158.230727315336;4260.488741351058;4288.206681763883 00:05:32 INFO - PROCESS | 7135 | |4;prototype.html;283.22900737083825;286.1829476843612;290.9040016794458;299.1593621922398;300.45617432447256;4724.811007559698;4838.564529192372;4893.6819106758085;4919.28670342801;4928.211486162206;4800.4719480857075;4811.182099043162;4823.348847905531;4827.25177597473;4849.199882019462;3591.8742844000467;3666;3678.3011227866755;3778.2065766189135;3779.2252588219417;3489.441689329708;3688.3360995020885;3697.297513472445;3700.5374328208973;3737.962620373802;3664.76179048361;3675.5221821163345;3687.8893633191046;3698.537682789651;3708.1656627258785;3683.1160521474785;3705.7961812100325;3730.794806285653;3744;3766.9058273543105;3156.4476216662224;3223.7259832913996;3263.6292757042097;3268.7742096713732;3287.917802054968;4582.679212455129;4655.88360290992;4662.930056049162;4665.626749860037;4760.857174284777;4276.593723596254;4276.615104640598;4288.742675439453;4326.351047342924;4332.28517294646;4902.90194196114;5000.699538304738;5038.345015148044;5052.292679024939;5090.338256026693;3579;3598.748087633867;3599.5320608321013;3599.5680518337704;3605.4952306676823;5054.9494505054845;5183.14478111115;5305.31030965972;5350.759215835296;5380.623356365056;3602.2615363850346;3615.837287322077;3620.873269435557;3623.547056617923;3646.781193128421;3629.6733294003666;3631.1285291529844;3631.8365673544754;3659.432787917877;3710.239400922804;4208.600182982612;4241.809118589671;4242.236397448489;4242.596953289432;4283.828646854091;4851.223804191312;5027.245913113063;5051.3433253676785;5086.745662716849;5094.166100203924;1255.598208573266;1276.789329760579;1276.8659290774522;1279.9824139808875;1280.7566562353122;770.5184259837602;797.3660939552954;807.7318609782702;810.9310708589836;810.9959450202712;4065.2072845794787;4066.8576599819457;4105.261053010487;4110.650594699424;4112.300908845504;4697.859064228079;4722.150012997693;4725.740084295397;4727.409073865767;4734.621230301567;4017.5982401760175;4044.2922488564973;4050.5949405059846;4055.6552693020835;4061.1877624475223;2507.2227609440765;2594.5718956372366;2828.1798278499004;2843.24653966699;2844.7013063628433;4951.678140920829;4983.626228032912;4994.850154495371;5011.123053465629;5018.096742586296;5299.2845965794895;5456.972715136479;5458.61789674719;5462.235287059815;5480.10936227001;4976.90969792688;4980.576650984707;4992.975035124801;4993.201087825931;5004.299398084271;5197.830488140138;5277;5299;5319.627626066138;5328.587924200013;5021.121303771898;5126.7180305083575;5189.844304670866;5193.584513238856;5197.480251974772;4647.814087436464;4808.3989501312335;4856.975715121402;4903.215485522299;4933.481984391731;3665.8167091645846;3682.1531047858607;3702.8703995360033;3703.3889408247337;3738.887833365003;5236.214567814858;5250.243622098429;5275.736213189249;5279.656822306538;5282.788688452419;4861;5049.5960323174795;5060.746962651779;5062.797488100435;5068.873278168076;5006.849794506171;5024.221245706921;5032.723200224023;5041.6722913010535;5053.538326246533;4967.528084831935;4988.501149884983;4990.276409920614;5010.194291196942;5017.924731129109;4815.3258543804595;5069.8732531687;5118.155504341742;5129.948700512947;5133.281340612392;4997.350344455343;5001.174806156943;5003.423921464727;5011.523905228997;5038.2190760432195 00:05:32 INFO - PROCESS | 7135 | |5;yui.html;629.7103332467066;630.4263120560291;651.11773546844;671.8421171024809;679.9456043516519;13107.820296173342;13207.207567545955;13223.140495867787;13339.466421343135;13794.655133621665;13096.476140954373;13141.342932853368;13240.801387979189;13246.205227686321;13252.072354935159;635.8378613453586;762.2377622377622;778.7507997440807;782.8825676148595;798.4091772088642;789.0767801672029;790.1071788878559;792.4769652029662;792.9920700793004;792.9960350198241;833.2417500074934;834.9749507514754;835.4945258118842;836.0844874862016;836.1847198980976;656.3698849104865;791.1692722641261;810.5055915891302;810.6554714246422;818.9058258300282;604.8669292755586;605.8636806718497;606.0485038489529;606.4117805728437;606.5875204860693;12333.136680432373;12364.44360003802;12397.566085186974;12450.875491245153;12458.750824983541;12264.38678066093;12545;12650.873491265062;12930.48278068876;13105.279209643466;11233.269837460539;11352.545898164064;11438.542458301657;11627.883721162765;11736.88263117375;4090.6931980101613;4107.219628270619;4124.1957818225455;4209.684273679486;4263.658907287409;57487.67635560085;57954.13068803971;57975.420245797424;58011;60229;9905.158061564847;10041.19670426364;10082.798344033079;10094.848577271347;10159.390436573829;18682.439526814218;18719;18739.531511712044;18788.342408015655;18839.246430142914;6676.132102826698;6725.428338591177;6775.1192344995825;6786;6817.216020157646;3670.4861319415304;3807.7715337079862;3857.9421308680394;3873.0511024799102;3977.6420122188565;2568.1396732094586;2688.5563881959647;2691.8654067296948;2693.165118813174;2695.380062585616;446.44194756554305;486.68122379840554;493.94566597674225;498.1357345006411;504.98990020200125;459.2858105645753;497.69391824028685;512.7718165416354;595.0360416125817;609.2749627942823;7478.663460144307;7564.016677831846;7583.658735356922;7712.035995500562;7745.806354841174;571.2174321179926;593.1517929361055;602.0908428273339;614.3764079459353;619.5229673151648;3644.653757893049;3715.4248074685;3765.2657731742047;3765.7175711821724;3802.1825307558456;105095;105483;106433;106952.46523767487;109345;89122.55438722765;89553.55223223842;90122.54938725264;90602.54698726464;91574.54212729027;59902.40097599055;60644.39355606387;80750.85595986932;82285.73131777748;82592;8463.23830855226;8496.575171241537;8585.356098292777;8798.208161265517;8840.520627218397;41959.580404196786;42136.36795448009;42161.57838421576;42351.36472952847;42652.360214596185;39124;48524.514754851996;55589.44410556005;56010.71994640001;60373.39626603854;11147.163962702993;11237.887621124011;11265.7746845061;11289.774204516028;11424.428778561205;12482.687932801753;12527.749445010866;12777.297248651414;13022.348882555645;13275.601731948056;12186.695332616755;12370.13409061357;12618.43217055253;12733;13194.868051319363;12760.07472115838;12952.352382381032;13229.933850330686;13249.735005300034;13287.867121328663;12124.515019399125;12178.208416452902;12501.874981250072;12530.436130374337;12572.308523030955;9362.48506332131;9380.202682771767;9549;9583.712488625353;9765.218782497524;9765.755856103655;9777.75555611087;10060.647877324258;10363.170946324426;10571.101456376295 00:05:32 INFO - PROCESS | 7135 | __end_tp_report 00:05:32 INFO - PROCESS | 7135 | __start_cc_report 00:05:32 INFO - PROCESS | 7135 | _x_x_mozilla_cycle_collect,1080 00:05:32 INFO - PROCESS | 7135 | __end_cc_report 00:05:32 INFO - PROCESS | 7135 | __startTimestamp1465974332496__endTimestamp 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | ------- Summary: start ------- 00:05:32 INFO - PROCESS | 7135 | Number of tests: 6 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | [#0] dojo.html Cycles:165 Average:4676.21 Median:4789.76 stddev:493.45 (10.3%) stddev-sans-first:466.24 00:05:32 INFO - PROCESS | 7135 | Values: 2561.5 2594.7 2595.4 2597.5 2611.0 4577.2 4640.6 4663.9 4688.9 4729.1 4689.4 4708.0 4723.8 4773.6 4804.3 4296.8 4303.8 4358.4 4409.9 4490.2 4403.2 4438.6 4457.3 4463.2 4484.7 4210.1 4227.2 4244.1 4260.0 4374.5 4322.8 4340.0 4343.5 4354.3 4359.4 4386.8 4394.1 4404.6 4421.0 4438.6 4556.8 4646.9 4787.8 4796.3 4834.8 5020.7 5048.6 5095.5 5109.9 5114.9 5059.1 5103.0 5105.3 5113.5 5123.6 4616.8 4660.2 4692.5 4787.0 4788.6 5106.5 5107.8 5143.2 5152.1 5163.4 4947.4 4964.5 4965.8 4967.4 4970.1 4970.9 4980.7 5018.3 5055.2 5079.3 5054.9 5060.5 5064.4 5088.7 5096.8 5023.1 5042.8 5042.8 5048.0 5099.9 4217.1 4266.1 4274.8 4330.7 4375.3 3737.0 3760.5 3775.1 3800.9 3857.8 4354.9 4358.8 4368.3 4410.2 4410.3 4964.8 5011.5 5036.1 5101.9 5145.3 4322.8 4339.9 4343.9 4374.2 4384.1 4548.1 4558.4 4561.2 4561.4 4603.1 4608.4 4727.4 4727.7 4772.3 4773.6 5086.9 5101.2 5103.6 5104.8 5153.1 4765.9 4789.5 4789.8 4790.7 4826.3 4846.0 4959.5 4969.0 4973.0 4987.3 5018.7 5049.5 5054.0 5056.4 5101.6 4815.6 4912.4 4921.0 4923.2 4973.7 4908.0 4936.6 4959.5 4976.9 4982.8 4920.0 4933.7 4962.4 4972.6 4973.3 4854.6 4935.4 5016.9 5064.4 5073.2 4701.5 4720.7 4740.9 4803.9 4878.2 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | [#1] ext.html Cycles:180 Average:47249.24 Median:17984.41 stddev:87965.63 (489.1%) stddev-sans-first:88142.47 00:05:32 INFO - PROCESS | 7135 | Values: 533.8 576.6 590.6 590.7 592.4 27543.6 38667.4 39618.0 39618.0 43181.1 40843.8 41173.0 41222.6 41224.0 41225.0 7565.8 7832.3 7982.6 7986.6 10121.7 9853.1 10228.7 10241.4 10253.2 10255.2 10239.5 10279.5 10295.9 10299.6 10303.9 7633.4 10078.0 10126.8 10347.5 10354.2 9846.8 10183.1 10186.6 10197.2 10197.6 38453.0 38986.4 38993.4 39060.4 39183.4 2953.5 3039.0 3054.0 3078.7 3220.0 29613.7 29943.0 30002.5 30214.0 30597.8 3288.3 3299.1 3342.8 3358.5 3367.3 244307.0 245220.0 245322.0 245371.0 245897.0 32450.8 54977.5 55286.0 55421.0 55440.7 32918.5 34714.5 34770.3 34789.0 34820.7 13004.0 13336.9 13437.5 13458.9 13464.0 9580.9 10311.5 10579.5 10585.5 10827.5 8046.4 8115.7 8158.9 8194.2 8209.2 3227.4 3245.8 3253.4 3253.4 3292.3 843.4 847.9 887.8 965.8 1033.3 27148.3 27738.3 27778.6 28130.3 28369.9 968.1 983.6 1009.9 1031.9 1111.6 14467.8 14573.0 14810.5 15111.6 15171.4 410785.0 415803.0 415907.0 416544.0 416742.0 50070.7 50690.0 50724.0 50749.7 50762.7 1100.9 1133.7 1168.7 1185.2 1225.2 26473.3 28814.1 29050.0 29615.3 29851.3 42151.8 42571.4 42720.0 42805.4 42932.6 314055.0 316668.0 317567.0 317829.0 318943.0 22777.8 25182.0 25817.6 25962.3 26219.3 40778.2 41331.0 41962.4 42036.4 42332.8 35236.3 35848.8 35961.8 36292.5 36593.8 35540.5 35669.5 35842.5 35963.8 36383.8 34911.1 35683.3 35862.6 36256.2 36329.6 31159.0 32474.5 32679.2 32680.5 32972.3 24768.4 25220.7 25334.8 25355.5 25392.4 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | [#2] jquery.html Cycles:180 Average:23892.98 Median:416.55 stddev:63305.68 (15197.6%) stddev-sans-first:63458.61 00:05:32 INFO - PROCESS | 7135 | Values: 357.2 357.7 360.3 367.4 369.8 15847.6 16987.3 17476.8 17826.0 17833.7 16227.8 16316.8 17126.7 17153.6 17185.1 5139.3 5291.6 5298.3 5325.8 5339.1 3763.7 5195.7 5882.4 6237.2 6242.6 6109.8 6246.8 6286.2 6286.6 6295.0 6094.6 6212.0 6214.2 6224.7 6225.8 3382.0 4943.6 5297.7 5301.2 5377.1 20177.9 20899.7 20904.7 21234.8 21236.4 1953.0 2082.6 2142.9 2177.7 2194.6 13128.2 13207.1 13289.2 13425.5 13557.9 1750.1 1801.8 1832.5 1846.3 1849.3 60936.4 63210.0 64079.0 64489.0 64577.0 9285.1 9312.2 9427.2 9627.3 9890.1 12553.9 12561.7 12673.2 12685.7 12694.6 7123.5 7188.6 7287.2 7333.2 7368.2 7078.8 7088.5 7119.5 7253.1 7267.9 6073.8 6151.0 6168.9 6200.1 6222.4 1544.7 1640.3 1648.8 1714.3 1755.4 363.1 366.9 389.8 856.1 857.3 9903.7 10345.2 10429.6 10481.6 10964.6 404.3 404.6 404.6 414.4 420.7 5633.9 5726.5 5763.5 5774.4 5784.4 371509.0 380022.0 380859.0 384780.0 393627.0 81011.0 84292.0 84477.0 84538.6 84634.6 418.7 427.4 428.9 429.3 430.2 9352.2 9870.0 9998.2 10018.4 10166.8 36899.3 37408.3 37986.8 39294.6 39379.4 47788.8 49572.3 54308.0 54729.2 55324.7 7431.0 7727.5 7773.1 7821.8 7849.7 10810.6 11643.2 11792.4 11806.6 11811.6 9813.7 9833.5 10025.5 10056.4 10138.7 10281.3 10322.5 10388.5 10478.6 10619.2 10020.5 10112.1 10129.5 10302.6 10639.9 7414.5 7623.0 7798.0 7800.2 8028.2 9861.1 9880.2 10007.4 10361.5 10732.4 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | [#3] mootools.html Cycles:180 Average:4941.19 Median:4817.35 stddev:2769.51 (57.5%) stddev-sans-first:2762.92 00:05:32 INFO - PROCESS | 7135 | Values: 1188.4 1363.3 1390.2 1465.3 1677.9 6581.8 7304.8 7565.7 7579.0 7726.4 7403.2 7482.1 7500.8 7515.7 7520.0 1867.8 1912.6 1915.7 2195.4 2224.1 1954.6 2156.8 2246.9 2247.0 2265.7 2160.3 2167.0 2169.3 2177.7 2179.8 1852.3 2138.8 2144.8 2147.6 2148.9 2063.5 2142.1 2146.7 2148.0 2154.7 7535.8 7595.8 7603.1 7607.8 7612.1 4460.5 4592.1 4592.6 4592.9 4593.6 2749.5 2777.9 2820.2 2880.8 2885.1 877.7 895.6 901.2 909.6 915.5 10152.7 10215.2 10218.7 10221.8 10234.3 4109.5 4149.0 4222.8 4248.7 4257.3 8729.4 8772.3 8777.9 8781.2 8794.0 4638.9 4646.0 4653.5 4653.8 4655.6 3599.9 3635.5 4122.8 4224.6 4227.4 3521.4 3568.5 3670.1 3676.4 3697.0 1134.6 1189.7 1199.9 1202.1 1209.4 659.6 721.7 757.9 787.9 796.7 4805.3 4829.4 4856.0 4856.0 4956.7 393.2 401.5 408.3 414.7 415.2 3633.5 3753.9 3829.8 3918.8 3934.8 9087.8 9100.9 9149.4 9208.2 9289.3 9016.2 9034.9 9046.1 9047.1 9169.5 7079.6 7170.8 7321.5 7325.0 7329.9 5272.1 5284.3 5310.9 5379.9 5433.2 8803.7 8928.2 9026.9 9032.1 9042.7 8083.3 8435.8 8450.4 8667.2 9053.1 5926.3 6083.2 6085.5 6574.5 6715.0 6619.9 6663.8 6780.3 6960.5 6983.8 6417.4 6437.6 6488.5 6495.8 6549.9 6354.6 6422.7 6469.6 6505.7 6526.2 6042.1 6130.3 6147.5 6198.4 6198.9 4026.4 4037.8 4079.5 4091.1 4123.5 4106.4 4149.6 4158.2 4260.5 4288.2 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | [#4] prototype.html Cycles:180 Average:4160.23 Median:4747.74 stddev:1232.78 (26.0%) stddev-sans-first:1201.40 00:05:32 INFO - PROCESS | 7135 | Values: 283.2 286.2 290.9 299.2 300.5 4724.8 4838.6 4893.7 4919.3 4928.2 4800.5 4811.2 4823.3 4827.3 4849.2 3591.9 3666.0 3678.3 3778.2 3779.2 3489.4 3688.3 3697.3 3700.5 3738.0 3664.8 3675.5 3687.9 3698.5 3708.2 3683.1 3705.8 3730.8 3744.0 3766.9 3156.4 3223.7 3263.6 3268.8 3287.9 4582.7 4655.9 4662.9 4665.6 4760.9 4276.6 4276.6 4288.7 4326.4 4332.3 4902.9 5000.7 5038.3 5052.3 5090.3 3579.0 3598.7 3599.5 3599.6 3605.5 5054.9 5183.1 5305.3 5350.8 5380.6 3602.3 3615.8 3620.9 3623.5 3646.8 3629.7 3631.1 3631.8 3659.4 3710.2 4208.6 4241.8 4242.2 4242.6 4283.8 4851.2 5027.2 5051.3 5086.7 5094.2 1255.6 1276.8 1276.9 1280.0 1280.8 770.5 797.4 807.7 810.9 811.0 4065.2 4066.9 4105.3 4110.7 4112.3 4697.9 4722.2 4725.7 4727.4 4734.6 4017.6 4044.3 4050.6 4055.7 4061.2 2507.2 2594.6 2828.2 2843.2 2844.7 4951.7 4983.6 4994.9 5011.1 5018.1 5299.3 5457.0 5458.6 5462.2 5480.1 4976.9 4980.6 4993.0 4993.2 5004.3 5197.8 5277.0 5299.0 5319.6 5328.6 5021.1 5126.7 5189.8 5193.6 5197.5 4647.8 4808.4 4857.0 4903.2 4933.5 3665.8 3682.2 3702.9 3703.4 3738.9 5236.2 5250.2 5275.7 5279.7 5282.8 4861.0 5049.6 5060.7 5062.8 5068.9 5006.8 5024.2 5032.7 5041.7 5053.5 4967.5 4988.5 4990.3 5010.2 5017.9 4815.3 5069.9 5118.2 5129.9 5133.3 4997.4 5001.2 5003.4 5011.5 5038.2 00:05:32 INFO - PROCESS | 7135 | 00:05:32 INFO - PROCESS | 7135 | [#5] yui.html Cycles:180 Average:17771.94 Median:23307.51 stddev:25901.01 (111.1%) stddev-sans-first:25941.69 00:05:32 INFO - PROCESS | 7135 | Values: 629.7 630.4 651.1 671.8 679.9 13107.8 13207.2 13223.1 13339.5 13794.7 13096.5 13141.3 13240.8 13246.2 13252.1 635.8 762.2 778.8 782.9 798.4 789.1 790.1 792.5 793.0 793.0 833.2 835.0 835.5 836.1 836.2 656.4 791.2 810.5 810.7 818.9 604.9 605.9 606.0 606.4 606.6 12333.1 12364.4 12397.6 12450.9 12458.8 12264.4 12545.0 12650.9 12930.5 13105.3 11233.3 11352.5 11438.5 11627.9 11736.9 4090.7 4107.2 4124.2 4209.7 4263.7 57487.7 57954.1 57975.4 58011.0 60229.0 9905.2 10041.2 10082.8 10094.8 10159.4 18682.4 18719.0 18739.5 18788.3 18839.2 6676.1 6725.4 6775.1 6786.0 6817.2 3670.5 3807.8 3857.9 3873.1 3977.6 2568.1 2688.6 2691.9 2693.2 2695.4 446.4 486.7 493.9 498.1 505.0 459.3 497.7 512.8 595.0 609.3 7478.7 7564.0 7583.7 7712.0 7745.8 571.2 593.2 602.1 614.4 619.5 3644.7 3715.4 3765.3 3765.7 3802.2 105095.0 105483.0 106433.0 106952.5 109345.0 89122.6 89553.6 90122.5 90602.5 91574.5 59902.4 60644.4 80750.9 82285.7 82592.0 8463.2 8496.6 8585.4 8798.2 8840.5 41959.6 42136.4 42161.6 42351.4 42652.4 39124.0 48524.5 55589.4 56010.7 60373.4 11147.2 11237.9 11265.8 11289.8 11424.4 12482.7 12527.7 12777.3 13022.3 13275.6 12186.7 12370.1 12618.4 12733.0 13194.9 12760.1 12952.4 13229.9 13249.7 13287.9 12124.5 12178.2 12501.9 12530.4 12572.3 9362.5 9380.2 9549.0 9583.7 9765.2 9765.8 9777.8 10060.6 10363.2 10571.1 00:05:32 INFO - PROCESS | 7135 | -------- Summary: end -------- 00:05:32 INFO - PROCESS | 7135 | 00:05:33 INFO - TEST-INFO | 7135: exit 0 00:05:33 INFO - TEST-OK | dromaeo_css | took 1120732ms 00:05:33 INFO - TEST-START | kraken 00:05:33 INFO - operating with platform_type : linux_ 00:05:33 INFO - Initialising browser for kraken test... 00:05:33 INFO - TEST-INFO | started process 7310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0cx4J/profile http://localhost:43857/getInfo.html) 00:05:37 INFO - PROCESS | 7310 | __metrics Screen width/height:1600/1200 00:05:37 INFO - PROCESS | 7310 | colorDepth:24 00:05:37 INFO - PROCESS | 7310 | Browser inner width/height: 1024/697 00:05:37 INFO - PROCESS | 7310 | __metrics 00:05:38 INFO - PROCESS | 7310 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:05:38 INFO - PROCESS | 7310 | console.error: PushService: 00:05:38 INFO - PROCESS | 7310 | stateChangeProcessEnqueue: Error transitioning state 00:05:38 INFO - PROCESS | 7310 | UnknownError 00:05:39 INFO - TEST-INFO | 7310: exit 0 00:05:39 INFO - Browser initialized. 00:05:39 INFO - Running cycle 1/1 for kraken test... 00:05:39 INFO - TEST-INFO | started process 7389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0cx4J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:05:51 INFO - PROCESS | 7389 | RSS: Main: 176136192 00:05:51 INFO - PROCESS | 7389 | 00:05:54 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43857/tests/kraken/driver.html?testName=audio-beat-detection) 00:05:55 INFO - PROCESS | 7389 | RSS: Main: 233779200 00:05:55 INFO - PROCESS | 7389 | 00:05:58 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43857/tests/kraken/driver.html?testName=audio-dft) 00:05:58 INFO - PROCESS | 7389 | RSS: Main: 221212672 00:05:58 INFO - PROCESS | 7389 | 00:06:02 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43857/tests/kraken/driver.html?testName=audio-fft) 00:06:02 INFO - PROCESS | 7389 | RSS: Main: 289402880 00:06:02 INFO - PROCESS | 7389 | 00:06:05 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43857/tests/kraken/driver.html?testName=audio-oscillator) 00:06:05 INFO - PROCESS | 7389 | RSS: Main: 199389184 00:06:05 INFO - PROCESS | 7389 | 00:06:07 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:06:08 INFO - PROCESS | 7389 | RSS: Main: 202850304 00:06:08 INFO - PROCESS | 7389 | 00:06:11 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43857/tests/kraken/driver.html?testName=imaging-darkroom) 00:06:12 INFO - PROCESS | 7389 | RSS: Main: 239263744 00:06:12 INFO - PROCESS | 7389 | 00:06:15 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43857/tests/kraken/driver.html?testName=imaging-desaturate) 00:06:16 INFO - PROCESS | 7389 | RSS: Main: 235319296 00:06:16 INFO - PROCESS | 7389 | 00:06:19 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43857/tests/kraken/driver.html?testName=json-parse-financial) 00:06:19 INFO - PROCESS | 7389 | RSS: Main: 237764608 00:06:19 INFO - PROCESS | 7389 | 00:06:21 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:06:22 INFO - PROCESS | 7389 | RSS: Main: 227401728 00:06:22 INFO - PROCESS | 7389 | 00:06:24 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:06:24 INFO - PROCESS | 7389 | RSS: Main: 233115648 00:06:24 INFO - PROCESS | 7389 | 00:06:26 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:06:27 INFO - PROCESS | 7389 | RSS: Main: 240242688 00:06:27 INFO - PROCESS | 7389 | 00:06:30 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:06:30 INFO - PROCESS | 7389 | RSS: Main: 241074176 00:06:30 INFO - PROCESS | 7389 | 00:06:33 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:06:34 INFO - PROCESS | 7389 | RSS: Main: 242515968 00:06:34 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | Cycle 1(1): loaded http://localhost:43857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43857/tests/kraken/driver.html?testName=ai-astar) 00:06:36 INFO - PROCESS | 7389 | RSS: Main: 285806592 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | __start_tp_report 00:06:36 INFO - PROCESS | 7389 | _x_x_mozilla_page_load 00:06:36 INFO - PROCESS | 7389 | _x_x_mozilla_page_load_details 00:06:36 INFO - PROCESS | 7389 | |i|pagename|runs| 00:06:36 INFO - PROCESS | 7389 | |0;ai-astar;113;108;113;114;112;114;112;113;114;113 00:06:36 INFO - PROCESS | 7389 | |1;audio-beat-detection;156;137;140;191;131;157;161;132;189;131 00:06:36 INFO - PROCESS | 7389 | |2;audio-dft;164;162;161;159;161;162;164;163;163;162 00:06:36 INFO - PROCESS | 7389 | |3;audio-fft;74;75;76;130;75;75;75;75;100;75 00:06:36 INFO - PROCESS | 7389 | |4;audio-oscillator;87;86;117;86;87;87;126;87;86;126 00:06:36 INFO - PROCESS | 7389 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 00:06:36 INFO - PROCESS | 7389 | |6;imaging-darkroom;149;147;145;146;145;146;146;145;146;146 00:06:36 INFO - PROCESS | 7389 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 00:06:36 INFO - PROCESS | 7389 | |8;json-parse-financial;62;61;62;63;64;65;63;65;64;63 00:06:36 INFO - PROCESS | 7389 | |9;json-stringify-tinderbox;65;65;66;65;65;65;65;65;66;67 00:06:36 INFO - PROCESS | 7389 | |10;stanford-crypto-aes;89;85;84;84;83;85;90;85;122;83 00:06:36 INFO - PROCESS | 7389 | |11;stanford-crypto-ccm;143;132;133;131;130;132;130;129;154;143 00:06:36 INFO - PROCESS | 7389 | |12;stanford-crypto-pbkdf2;176;172;179;173;173;170;170;171;170;169 00:06:36 INFO - PROCESS | 7389 | |13;stanford-crypto-sha256-iterative;68;69;68;67;68;66;69;68;68;66 00:06:36 INFO - PROCESS | 7389 | __end_tp_report 00:06:36 INFO - PROCESS | 7389 | __start_cc_report 00:06:36 INFO - PROCESS | 7389 | _x_x_mozilla_cycle_collect,1898 00:06:36 INFO - PROCESS | 7389 | __end_cc_report 00:06:36 INFO - PROCESS | 7389 | __startTimestamp1465974396567__endTimestamp 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | ------- Summary: start ------- 00:06:36 INFO - PROCESS | 7389 | Number of tests: 14 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:1.88 00:06:36 INFO - PROCESS | 7389 | Values: 113.0 108.0 113.0 114.0 112.0 114.0 112.0 113.0 114.0 113.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:156.50 stddev:22.76 (14.5%) stddev-sans-first:24.10 00:06:36 INFO - PROCESS | 7389 | Values: 156.0 137.0 140.0 191.0 131.0 157.0 161.0 132.0 189.0 131.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.52 (0.9%) stddev-sans-first:1.45 00:06:36 INFO - PROCESS | 7389 | Values: 164.0 162.0 161.0 159.0 161.0 162.0 164.0 163.0 163.0 162.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:18.29 (24.4%) stddev-sans-first:19.11 00:06:36 INFO - PROCESS | 7389 | Values: 74.0 75.0 76.0 130.0 75.0 75.0 75.0 75.0 100.0 75.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:86.50 stddev:17.77 (20.5%) stddev-sans-first:18.44 00:06:36 INFO - PROCESS | 7389 | Values: 87.0 86.0 117.0 86.0 87.0 87.0 126.0 87.0 86.0 126.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 00:06:36 INFO - PROCESS | 7389 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:1.20 (0.8%) stddev-sans-first:0.67 00:06:36 INFO - PROCESS | 7389 | Values: 149.0 147.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:06:36 INFO - PROCESS | 7389 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:1.32 (2.1%) stddev-sans-first:1.32 00:06:36 INFO - PROCESS | 7389 | Values: 62.0 61.0 62.0 63.0 64.0 65.0 63.0 65.0 64.0 63.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 00:06:36 INFO - PROCESS | 7389 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 67.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:85.00 stddev:11.83 (13.9%) stddev-sans-first:12.55 00:06:36 INFO - PROCESS | 7389 | Values: 89.0 85.0 84.0 84.0 83.0 85.0 90.0 85.0 122.0 83.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:132.50 stddev:8.22 (6.2%) stddev-sans-first:8.28 00:06:36 INFO - PROCESS | 7389 | Values: 143.0 132.0 133.0 131.0 130.0 132.0 130.0 129.0 154.0 143.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.50 stddev:3.13 (1.8%) stddev-sans-first:3.02 00:06:36 INFO - PROCESS | 7389 | Values: 176.0 172.0 179.0 173.0 173.0 170.0 170.0 171.0 170.0 169.0 00:06:36 INFO - PROCESS | 7389 | 00:06:36 INFO - PROCESS | 7389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 00:06:36 INFO - PROCESS | 7389 | Values: 68.0 69.0 68.0 67.0 68.0 66.0 69.0 68.0 68.0 66.0 00:06:36 INFO - PROCESS | 7389 | -------- Summary: end -------- 00:06:36 INFO - PROCESS | 7389 | 00:06:37 INFO - TEST-INFO | 7389: exit 0 00:06:37 INFO - TEST-OK | kraken | took 64308ms 00:06:37 INFO - SUITE-END | took 1185s 00:06:37 INFO - Completed test suite (00:19:45) 00:06:37 INFO - javascript benchmark 00:06:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.500507401055, 2594.6886373635166, 2595.4290056187633, 2597.5194589001035, 2611.0469678567315, 4577.153226653071, 4640.6055485283705, 4663.930041049387, 4688.929666055008, 4729.054189162164, 4689.390379250693, 4707.976460117703, 4723.787429565669, 4773.618110551148, 4804.25534042224, 4296.806643701041, 4303.763293018883, 4358.43340365752, 4409.889752756175, 4490.191765482212, 4403.185410699015, 4438.622717069037, 4457.264551349023, 4463.174312752135, 4484.730916145026, 4210.073783767566, 4227.239096962546, 4244.0663054128045, 4260.0, 4374.518802931675, 4322.762248076355, 4340.023494713696, 4343.500497442771, 4354.259775838115, 4359.411479450266, 4386.758728269944, 4394.099209662011, 4404.559544045602, 4421.049474363027, 4438.578335058164, 4556.77216139195, 4646.883827904296, 4787.832425865078, 4796.304535842318, 4834.830780922686, 5020.698758074527, 5048.6465947383695, 5095.541401273866, 5109.923351149736, 5114.923276150861, 5059.089363914494, 5103.004914041763, 5105.336306280197, 5113.51421614946, 5123.590112791005, 4616.815327386867, 4660.231061874821, 4692.4603670577635, 4787.0, 4788.61691064714, 5106.463821298785, 5107.846764597068, 5143.151380022255, 5152.124138896396, 5163.3545806774155, 4947.356843610308, 4964.478729733398, 4965.801367945314, 4967.40391153064, 4970.080535101018, 4970.925436118461, 4980.701157930535, 5018.2974383586325, 5055.16589762685, 5079.263506791494, 5054.898902021939, 5060.49395060491, 5064.442911279756, 5088.745562721849, 5096.770645320969, 5023.14606516893, 5042.773075211624, 5042.848714538496, 5048.0, 5099.87250318745, 4217.0511634881905, 4266.0827921996915, 4274.829006839754, 4330.7401555906745, 4375.256206444912, 3736.981315093407, 3760.4735337052834, 3775.1317197044286, 3800.923981520354, 3857.787821669779, 4354.8911277217685, 4358.8038538265855, 4368.344748287719, 4410.20616289071, 4410.316400957857, 4964.801407943642, 5011.523905228997, 5036.11867923112, 5101.9489805101475, 5145.279660847485, 4322.827086916488, 4339.869803905888, 4343.9348409773875, 4374.19077470669, 4384.101259241847, 4548.135854187693, 4558.384618076518, 4561.178987782231, 4561.429821272341, 4603.056373443436, 4608.446986361658, 4727.3854398927915, 4727.716337019721, 4772.331873537638, 4773.64197685182, 5086.923696144635, 5101.183810590288, 5103.591712663052, 5104.846854594368, 5153.072446959433, 4765.928511072406, 4789.521047895182, 4789.760511974457, 4790.7365094920115, 4826.300186473012, 4845.9757701211265, 4959.479254678206, 4968.950310496849, 4973.0, 4987.2768448574025, 5018.723970181529, 5049.545540901337, 5053.974730126326, 5056.367954005749, 5101.642884998015, 4815.566599006106, 4912.38595175603, 4920.950790492192, 4923.187674033888, 4973.676711013773, 4908.042931628298, 4936.605071594336, 4959.479254678206, 4976.875578110431, 4982.775775090202, 4919.950800491949, 4933.679310844784, 4962.354893863919, 4972.552470277692, 4973.328600638867, 4854.5873600744335, 4935.407751069894, 5016.924746128738, 5064.442911279682, 5073.239014147907, 4701.482836888008, 4720.716756994591, 4740.905181896412, 4803.903921921612, 4878.243872199815], "value": 4644.085807856845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.8029077968414, 576.6338375131791, 590.6042951222678, 590.6721769417973, 592.3957563285446, 27543.586846197322, 38667.41998870016, 39618.0, 39618.0, 43181.136377272516, 40843.79578102113, 41173.0, 41222.58777412225, 41224.0, 41225.0, 7565.773026809205, 7832.255935686129, 7982.560959147245, 7986.640601172932, 10121.746956326077, 9853.113219810215, 10228.74428139295, 10241.436720980342, 10253.17974562037, 10255.179585633168, 10239.488025598728, 10279.537420816045, 10295.897041029606, 10299.588016479369, 10303.896961030407, 7633.351165150996, 10078.0, 10126.797464050715, 10347.482625868677, 10354.17166626668, 9846.803063938753, 10183.134433573156, 10186.59253629854, 10197.18422526196, 10197.592096316139, 38453.0, 38986.41520377197, 38993.41509877354, 39060.41409378862, 39183.41224881629, 2953.4536110819568, 3039.0, 3054.0, 3078.6921307869256, 3219.985704503074, 29613.70386296131, 29943.0, 30002.549961750592, 30214.0, 30597.847010765025, 3288.3094550144497, 3299.0597679661423, 3342.8328583570724, 3358.462645976632, 3367.2760356523463, 244307.0, 245220.0, 245322.0, 245371.0, 245896.99999999822, 32450.83774581112, 54977.45022549803, 55286.0, 55421.0, 55440.72279638576, 32918.506222406686, 34714.479282810775, 34770.30459390798, 34789.0, 34820.65179348225, 13004.0, 13336.866631333562, 13437.462501499831, 13458.865411345958, 13464.0, 9580.904190958001, 10311.535980880879, 10579.5239214234, 10585.4707264638, 10827.458627068616, 8046.436749427484, 8115.6753729851325, 8158.877616835753, 8194.180581941877, 8209.220124088202, 3227.386796508656, 3245.8214798186327, 3253.3655937092512, 3253.3818574470774, 3292.27569934614, 843.4306842881031, 847.872819077131, 887.7691800132012, 965.8068386322764, 1033.2715435617872, 27148.321291967462, 27738.306542336602, 27778.583321250197, 28130.2967425816, 28369.858150709115, 968.138356862393, 983.5573991703619, 1009.9192064634811, 1031.8555402243692, 1111.6053800900725, 14467.78298325526, 14573.0, 14810.481633142788, 15111.622209444851, 15171.393144274105, 410785.0, 415803.0, 415907.0, 416544.0, 416742.0, 50070.749646251534, 50690.0, 50724.0, 50749.74625126851, 50762.74618626957, 1100.8513850630222, 1133.7052366384635, 1168.6961390038482, 1185.1526158796503, 1225.1913736933582, 26473.33816654599, 28814.135575932756, 29050.0, 29615.25961850971, 29851.253718657208, 42151.7892410536, 42571.36142957796, 42720.0, 42805.35791963061, 42932.57067429286, 314055.0, 316668.0, 317567.0, 317829.0, 318943.0, 22777.772222277566, 25182.0, 25817.6127358086, 25962.312449691464, 26219.344516387242, 40778.18443631051, 41331.0, 41962.37056444095, 42036.36945445882, 42332.788336058125, 35236.34621526726, 35848.82075589606, 35961.82019089888, 36292.45561316635, 36593.81703091467, 35540.466892997145, 35669.46495802513, 35842.462363064056, 35963.820180898925, 36383.81808090943, 34911.12722181966, 35683.28633427265, 35862.64137358593, 36256.19309972415, 36329.63670363368, 31159.0, 32474.512882306313, 32679.18302042468, 32680.50979235361, 32972.340553188325, 24768.380790480383, 25220.747792522572, 25334.792975721066, 25355.492890141726, 25392.365190870376], "value": 17026.9634989409, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1963083063108, 357.7209776374428, 360.3423751653232, 367.4433233651018, 369.82802996606574, 15847.603809904758, 16987.320507179713, 17476.82523174768, 17826.0, 17833.73249401257, 16227.83772162278, 16316.836831631681, 17126.657466850655, 17153.57116072099, 17185.140742962834, 5139.25480805283, 5291.629585928987, 5298.258243845846, 5325.840224793243, 5339.092354299759, 3763.680087192592, 5195.66228195168, 5882.411758824126, 6237.220347456568, 6242.625442473443, 6109.786157484489, 6246.812595622116, 6286.151369565118, 6286.622802631834, 6295.0, 6094.60385074971, 6212.037134244154, 6214.223222097238, 6224.719887605046, 6225.7509699611965, 3382.0, 4943.579795717368, 5297.682139071668, 5301.204819277139, 5377.11277639189, 20177.8991105045, 20899.68650470244, 20904.686429703568, 21234.8147777833, 21236.36290911275, 1952.9804701952942, 2082.6147162774937, 2142.8500004999655, 2177.684235785818, 2194.5501172259646, 13128.212307261594, 13207.141535800141, 13289.20264784116, 13425.462981480729, 13557.864421355758, 1750.1074452029557, 1801.7837859456818, 1832.4502649205185, 1846.26149540185, 1849.2880241107136, 60936.39063609396, 63209.99999999954, 64079.0, 64489.0, 64577.0, 9285.117913798178, 9312.161905428544, 9427.19868811145, 9627.277954153467, 9890.060444257784, 12553.874461255271, 12561.685957850945, 12673.17624354414, 12685.73142685724, 12694.555690550786, 7123.465740069516, 7188.604626745475, 7287.234840341794, 7333.230010848891, 7368.226336234726, 7078.823029424306, 7088.503804733722, 7119.501634885612, 7253.1296244451005, 7267.854642907112, 6073.787417440369, 6151.0, 6168.907466388007, 6200.131981522591, 6222.377762223741, 1544.6987837371605, 1640.261882153036, 1648.777415048977, 1714.3399791080274, 1755.3768412213735, 363.08864749479, 366.948627192188, 389.7583498231115, 856.1438561438562, 857.3269983063266, 9903.7028889132, 10345.224108191916, 10429.634962776267, 10481.580736770597, 10964.56141754321, 404.26222144586245, 404.61561516559385, 404.62976376615654, 414.40532835380725, 420.74334655860514, 5633.887322253532, 5726.484616384545, 5763.538916886639, 5774.364819869811, 5784.421557844266, 371509.0, 380022.0, 380859.0, 384780.0, 393627.0, 81011.0, 84292.0, 84477.0, 84538.57730711307, 84634.5768271167, 418.6964450773165, 427.42084475535825, 428.8734823227093, 429.2830972276306, 430.2234466787416, 9352.158305752515, 9870.0, 9998.150157236716, 10018.39889606626, 10166.796664066826, 36899.26201476009, 37408.251834963696, 37986.810065949496, 39294.607053929096, 39379.4248230079, 47788.7610561945, 49572.25641615451, 54308.0, 54729.1790623133, 55324.72337638447, 7431.0, 7727.459077864721, 7773.144954055162, 7821.843563128592, 7849.725259615886, 10810.621628242974, 11643.243189192675, 11792.351420671945, 11806.586769463027, 11811.586594469496, 9813.656522021694, 9833.5083245836, 10025.548850301608, 10056.446895420822, 10138.695839124837, 10281.2803103785, 10322.48387580633, 10388.48057597102, 10478.58085676595, 10619.203559732896, 10020.549075291776, 10112.089911907964, 10129.544170512492, 10302.639407620698, 10639.8936010642, 7414.518056326321, 7622.961885190539, 7798.025246844145, 7800.180980996914, 8028.157043510348, 9861.112499875046, 9880.160186384237, 10007.399556026661, 10361.533730982275, 10732.356058636507], "value": 7664.8056713413325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.4057971014493, 1363.297901580686, 1390.1867407566574, 1465.325950062971, 1677.8573821225195, 6581.7696380626685, 7304.780856574304, 7565.735199268027, 7578.96210518948, 7726.42051846111, 7403.2226616205335, 7482.064741907262, 7500.774976750707, 7515.699372025112, 7519.962400187991, 1867.7758668959675, 1912.5887934094167, 1915.6647586672345, 2195.407240045191, 2224.077008041661, 1954.6286205620959, 2156.751973523041, 2246.9438264043365, 2247.0, 2265.716785401825, 2160.2655097266925, 2167.0464995402053, 2169.349195241421, 2177.7495588007423, 2179.8147157491553, 1852.2776117314258, 2138.828893688501, 2144.839137064711, 2147.6134295826746, 2148.9247876324253, 2063.484128967758, 2142.0574947023415, 2146.667266573668, 2147.978520214809, 2154.6875703022974, 7535.849283014364, 7595.772126836204, 7603.0876294844975, 7607.771766847003, 7612.1246056703085, 4460.4647442306805, 4592.1045396147765, 4592.563706447882, 4592.862214133548, 4593.609543188833, 2749.4913441013477, 2777.9444411111867, 2820.182147177316, 2880.7839412043973, 2885.0623547347195, 877.666486735043, 895.6417433026776, 901.2159421303443, 909.6497848328441, 915.5102020419043, 10152.746181345452, 10215.182785377152, 10218.744531386776, 10221.79556408875, 10234.334768240114, 4109.506859176918, 4148.979255103705, 4222.767747773902, 4248.660107191417, 4257.340112282601, 8729.388942773945, 8772.34207434445, 8777.91222087771, 8781.209691127702, 8793.956030219808, 4638.907221855544, 4646.0, 4653.53464653532, 4653.767311634405, 4655.580997710154, 3599.892003239907, 3635.5273814404486, 4122.835086596562, 4224.55642157569, 4227.429297044921, 3521.4013617685055, 3568.4825700273313, 3670.100825297819, 3676.3933950897804, 3697.0387699198404, 1134.5915470430639, 1189.7323102302087, 1199.8800119987932, 1202.0864143251017, 1209.4013463335705, 659.6306068601599, 721.7257442171941, 757.8749506331394, 787.8857565652949, 796.7092011415791, 4805.303231031481, 4829.396325459317, 4855.975720121377, 4856.0, 4956.727379994135, 393.20572443664213, 401.46204086523613, 408.33033824527797, 414.68691138190474, 415.198666573516, 3633.4913112164318, 3753.943690844585, 3829.751066180689, 3918.8236529356245, 3934.842606295716, 9087.772805679911, 9100.8634870477, 9149.40528865635, 9208.217301529312, 9289.349745517884, 9016.233620142362, 9034.86447703285, 9046.05016473274, 9047.095290471032, 9169.541522923828, 7079.575225486487, 7170.784876453715, 7321.524100933529, 7325.04774379338, 7329.9267007329245, 5272.077386457431, 5284.339457567804, 5310.867228319168, 5379.946200537945, 5433.157860531624, 8803.735887923373, 8928.241099506615, 9026.909730902607, 9032.096790321179, 9042.683506077256, 8083.312918402002, 8435.83128337442, 8450.408471406943, 8667.17661822126, 9053.139951704577, 5926.259217597801, 6083.178770866053, 6085.513158947362, 6574.539782215199, 6714.966425168039, 6619.867602648016, 6663.766768163091, 6780.32196780318, 6960.547564408297, 6983.825404364931, 6417.358264173732, 6437.581557198767, 6488.480921526361, 6495.805125846232, 6549.901751473636, 6354.586951848115, 6422.743090276524, 6469.5794773339585, 6505.73977040932, 6526.184226971629, 6042.123892035718, 6130.295016073031, 6147.508199343953, 6198.411150940653, 6198.907016394848, 4026.3960405939342, 4037.7577345359373, 4079.4696689430184, 4091.0999580092334, 4123.505179378494, 4106.3635136553885, 4149.585041495826, 4158.230727315336, 4260.488741351058, 4288.206681763883], "value": 3918.727048563981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.22900737083825, 286.1829476843612, 290.9040016794458, 299.1593621922398, 300.45617432447256, 4724.811007559698, 4838.564529192372, 4893.6819106758085, 4919.28670342801, 4928.211486162206, 4800.4719480857075, 4811.182099043162, 4823.348847905531, 4827.25177597473, 4849.199882019462, 3591.8742844000467, 3666.0, 3678.3011227866755, 3778.2065766189135, 3779.2252588219417, 3489.441689329708, 3688.3360995020885, 3697.297513472445, 3700.5374328208973, 3737.962620373802, 3664.76179048361, 3675.5221821163345, 3687.8893633191046, 3698.537682789651, 3708.1656627258785, 3683.1160521474785, 3705.7961812100325, 3730.794806285653, 3744.0, 3766.9058273543105, 3156.4476216662224, 3223.7259832913996, 3263.6292757042097, 3268.7742096713732, 3287.917802054968, 4582.679212455129, 4655.88360290992, 4662.930056049162, 4665.626749860037, 4760.857174284777, 4276.593723596254, 4276.615104640598, 4288.742675439453, 4326.351047342924, 4332.28517294646, 4902.90194196114, 5000.699538304738, 5038.345015148044, 5052.292679024939, 5090.338256026693, 3579.0, 3598.748087633867, 3599.5320608321013, 3599.5680518337704, 3605.4952306676823, 5054.9494505054845, 5183.14478111115, 5305.31030965972, 5350.759215835296, 5380.623356365056, 3602.2615363850346, 3615.837287322077, 3620.873269435557, 3623.547056617923, 3646.781193128421, 3629.6733294003666, 3631.1285291529844, 3631.8365673544754, 3659.432787917877, 3710.239400922804, 4208.600182982612, 4241.809118589671, 4242.236397448489, 4242.596953289432, 4283.828646854091, 4851.223804191312, 5027.245913113063, 5051.3433253676785, 5086.745662716849, 5094.166100203924, 1255.598208573266, 1276.789329760579, 1276.8659290774522, 1279.9824139808875, 1280.7566562353122, 770.5184259837602, 797.3660939552954, 807.7318609782702, 810.9310708589836, 810.9959450202712, 4065.2072845794787, 4066.8576599819457, 4105.261053010487, 4110.650594699424, 4112.300908845504, 4697.859064228079, 4722.150012997693, 4725.740084295397, 4727.409073865767, 4734.621230301567, 4017.5982401760175, 4044.2922488564973, 4050.5949405059846, 4055.6552693020835, 4061.1877624475223, 2507.2227609440765, 2594.5718956372366, 2828.1798278499004, 2843.24653966699, 2844.7013063628433, 4951.678140920829, 4983.626228032912, 4994.850154495371, 5011.123053465629, 5018.096742586296, 5299.2845965794895, 5456.972715136479, 5458.61789674719, 5462.235287059815, 5480.10936227001, 4976.90969792688, 4980.576650984707, 4992.975035124801, 4993.201087825931, 5004.299398084271, 5197.830488140138, 5277.0, 5299.0, 5319.627626066138, 5328.587924200013, 5021.121303771898, 5126.7180305083575, 5189.844304670866, 5193.584513238856, 5197.480251974772, 4647.814087436464, 4808.3989501312335, 4856.975715121402, 4903.215485522299, 4933.481984391731, 3665.8167091645846, 3682.1531047858607, 3702.8703995360033, 3703.3889408247337, 3738.887833365003, 5236.214567814858, 5250.243622098429, 5275.736213189249, 5279.656822306538, 5282.788688452419, 4861.0, 5049.5960323174795, 5060.746962651779, 5062.797488100435, 5068.873278168076, 5006.849794506171, 5024.221245706921, 5032.723200224023, 5041.6722913010535, 5053.538326246533, 4967.528084831935, 4988.501149884983, 4990.276409920614, 5010.194291196942, 5017.924731129109, 4815.3258543804595, 5069.8732531687, 5118.155504341742, 5129.948700512947, 5133.281340612392, 4997.350344455343, 5001.174806156943, 5003.423921464727, 5011.523905228997, 5038.2190760432195], "value": 3764.7043938027737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.7103332467066, 630.4263120560291, 651.11773546844, 671.8421171024809, 679.9456043516519, 13107.820296173342, 13207.207567545955, 13223.140495867787, 13339.466421343135, 13794.655133621665, 13096.476140954373, 13141.342932853368, 13240.801387979189, 13246.205227686321, 13252.072354935159, 635.8378613453586, 762.2377622377622, 778.7507997440807, 782.8825676148595, 798.4091772088642, 789.0767801672029, 790.1071788878559, 792.4769652029662, 792.9920700793004, 792.9960350198241, 833.2417500074934, 834.9749507514754, 835.4945258118842, 836.0844874862016, 836.1847198980976, 656.3698849104865, 791.1692722641261, 810.5055915891302, 810.6554714246422, 818.9058258300282, 604.8669292755586, 605.8636806718497, 606.0485038489529, 606.4117805728437, 606.5875204860693, 12333.136680432373, 12364.44360003802, 12397.566085186974, 12450.875491245153, 12458.750824983541, 12264.38678066093, 12545.0, 12650.873491265062, 12930.48278068876, 13105.279209643466, 11233.269837460539, 11352.545898164064, 11438.542458301657, 11627.883721162765, 11736.88263117375, 4090.6931980101613, 4107.219628270619, 4124.1957818225455, 4209.684273679486, 4263.658907287409, 57487.67635560085, 57954.13068803971, 57975.420245797424, 58011.0, 60229.0, 9905.158061564847, 10041.19670426364, 10082.798344033079, 10094.848577271347, 10159.390436573829, 18682.439526814218, 18719.0, 18739.531511712044, 18788.342408015655, 18839.246430142914, 6676.132102826698, 6725.428338591177, 6775.1192344995825, 6786.0, 6817.216020157646, 3670.4861319415304, 3807.7715337079862, 3857.9421308680394, 3873.0511024799102, 3977.6420122188565, 2568.1396732094586, 2688.5563881959647, 2691.8654067296948, 2693.165118813174, 2695.380062585616, 446.44194756554305, 486.68122379840554, 493.94566597674225, 498.1357345006411, 504.98990020200125, 459.2858105645753, 497.69391824028685, 512.7718165416354, 595.0360416125817, 609.2749627942823, 7478.663460144307, 7564.016677831846, 7583.658735356922, 7712.035995500562, 7745.806354841174, 571.2174321179926, 593.1517929361055, 602.0908428273339, 614.3764079459353, 619.5229673151648, 3644.653757893049, 3715.4248074685, 3765.2657731742047, 3765.7175711821724, 3802.1825307558456, 105095.0, 105483.0, 106433.0, 106952.46523767487, 109345.0, 89122.55438722765, 89553.55223223842, 90122.54938725264, 90602.54698726464, 91574.54212729027, 59902.40097599055, 60644.39355606387, 80750.85595986932, 82285.73131777748, 82592.0, 8463.23830855226, 8496.575171241537, 8585.356098292777, 8798.208161265517, 8840.520627218397, 41959.580404196786, 42136.36795448009, 42161.57838421576, 42351.36472952847, 42652.360214596185, 39124.0, 48524.514754851996, 55589.44410556005, 56010.71994640001, 60373.39626603854, 11147.163962702993, 11237.887621124011, 11265.7746845061, 11289.774204516028, 11424.428778561205, 12482.687932801753, 12527.749445010866, 12777.297248651414, 13022.348882555645, 13275.601731948056, 12186.695332616755, 12370.13409061357, 12618.43217055253, 12733.0, 13194.868051319363, 12760.07472115838, 12952.352382381032, 13229.933850330686, 13249.735005300034, 13287.867121328663, 12124.515019399125, 12178.208416452902, 12501.874981250072, 12530.436130374337, 12572.308523030955, 9362.48506332131, 9380.202682771767, 9549.0, 9583.712488625353, 9765.218782497524, 9765.755856103655, 9777.75555611087, 10060.647877324258, 10363.170946324426, 10571.101456376295], "value": 6564.466711942837, "unit": "score"}], "name": "dromaeo_css", "value": 6234.151141208763, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 114.0, 112.0, 114.0, 112.0, 113.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 137.0, 140.0, 191.0, 131.0, 157.0, 161.0, 132.0, 189.0, 131.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 159.0, 161.0, 162.0, 164.0, 163.0, 163.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 130.0, 75.0, 75.0, 75.0, 75.0, 100.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 117.0, 86.0, 87.0, 87.0, 126.0, 87.0, 86.0, 126.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 63.0, 64.0, 65.0, 63.0, 65.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 84.0, 84.0, 83.0, 85.0, 90.0, 85.0, 122.0, 83.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 133.0, 131.0, 130.0, 132.0, 130.0, 129.0, 154.0, 143.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 179.0, 173.0, 173.0, 170.0, 170.0, 171.0, 170.0, 169.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 68.0, 66.0, 69.0, 68.0, 68.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1559.3000000000002, "alertThreshold": 2.0}]} 00:06:37 INFO - Return code: 0 00:06:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:06:37 INFO - # TBPL SUCCESS # 00:06:37 INFO - Running post-action listener: _resource_record_post_action 00:06:37 INFO - ##### 00:06:37 INFO - ##### Finished run-tests step (success) 00:06:37 INFO - ##### 00:06:37 INFO - Running post-run listener: _resource_record_post_run 00:06:37 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532754432; Read time: 16; Write time: 417588 00:06:37 INFO - TinderboxPrint: CPU usage
13.2% 00:06:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:06:37 INFO - TinderboxPrint: I/O write bytes / time
532,754,432 / 417,588 00:06:37 INFO - TinderboxPrint: CPU idle
8,329.4 (86.8%) 00:06:37 INFO - TinderboxPrint: CPU user
1,216.8 (12.7%) 00:06:37 INFO - TinderboxPrint: Swap in / out
0 / 0 00:06:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245006336; Read time: 0; Write time: 246420 00:06:37 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287162368; Read time: 16; Write time: 171144 00:06:38 INFO - Running post-run listener: _upload_blobber_files 00:06:38 INFO - Blob upload gear active. 00:06:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:06:38 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 00:06:38 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:06:38 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:06:38 INFO - (blobuploader) - INFO - Open directory for files ... 00:06:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:06:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:06:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:42 INFO - (blobuploader) - INFO - Done attempting. 00:06:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:06:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:06:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:42 INFO - (blobuploader) - INFO - Done attempting. 00:06:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:06:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:06:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:43 INFO - (blobuploader) - INFO - Done attempting. 00:06:43 INFO - (blobuploader) - INFO - Iteration through files over. 00:06:43 INFO - Return code: 0 00:06:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:06:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:06:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f32cbd49b0c4d4b68046d417af3a6435cf8f554f5ef5ecf4415cfe6d023f6617af3f2928d1858ead2d284fee2a4f7b668ed4a0e597f379b3f86650e45c1732c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb712526d48a4320becf9b8937e1c5b9615b45cac69959650868ba859be0041254f4596d665230ae8234f209617acb9e1bca004b2b95fb4a405914dcfacee32c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa77d93e9ff7196a7c8f23277d725947e8a551ce7de0ec33bfeca3e754b96dec26b2ad818996c5ceac699559e748140886951a921d71689680cd299808b4181d"} 00:06:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:06:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:06:43 INFO - Contents: 00:06:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f32cbd49b0c4d4b68046d417af3a6435cf8f554f5ef5ecf4415cfe6d023f6617af3f2928d1858ead2d284fee2a4f7b668ed4a0e597f379b3f86650e45c1732c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb712526d48a4320becf9b8937e1c5b9615b45cac69959650868ba859be0041254f4596d665230ae8234f209617acb9e1bca004b2b95fb4a405914dcfacee32c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa77d93e9ff7196a7c8f23277d725947e8a551ce7de0ec33bfeca3e754b96dec26b2ad818996c5ceac699559e748140886951a921d71689680cd299808b4181d"} 00:06:43 INFO - Running post-run listener: copy_logs_to_upload_dir 00:06:43 INFO - Copying logs to upload dir... 00:06:43 INFO - mkdir: /builds/slave/test/build/upload/logs 00:06:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.888240 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-15 00:06:43.271443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:43.274947) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f32cbd49b0c4d4b68046d417af3a6435cf8f554f5ef5ecf4415cfe6d023f6617af3f2928d1858ead2d284fee2a4f7b668ed4a0e597f379b3f86650e45c1732c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb712526d48a4320becf9b8937e1c5b9615b45cac69959650868ba859be0041254f4596d665230ae8234f209617acb9e1bca004b2b95fb4a405914dcfacee32c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa77d93e9ff7196a7c8f23277d725947e8a551ce7de0ec33bfeca3e754b96dec26b2ad818996c5ceac699559e748140886951a921d71689680cd299808b4181d"} build_url:https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/M1JSttAGSgiuAqATgCaYoA/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/Fx-Team-Non-PGO/sha512/f32cbd49b0c4d4b68046d417af3a6435cf8f554f5ef5ecf4415cfe6d023f6617af3f2928d1858ead2d284fee2a4f7b668ed4a0e597f379b3f86650e45c1732c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb712526d48a4320becf9b8937e1c5b9615b45cac69959650868ba859be0041254f4596d665230ae8234f209617acb9e1bca004b2b95fb4a405914dcfacee32c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa77d93e9ff7196a7c8f23277d725947e8a551ce7de0ec33bfeca3e754b96dec26b2ad818996c5ceac699559e748140886951a921d71689680cd299808b4181d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:43.303423) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:43.303800) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465971762.33978-1508733432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 00:06:43.386786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:06:43.387161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:06:43.387509) ========= ========= Total master_lag: 0.21 =========