builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1468996558.6 results: success (0) buildid: 20160719230124 builduid: 1f77a000c9c749cd9d7d76be7f0a3eab revision: 4553ad09496a74d6d613d60ceefc22367cd4ee9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.604666) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.605181) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.605504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.621296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.621786) ========= 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=00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 23:35:58-- 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% 43.0M=0s 2016-07-19 23:35:58 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.720383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.720685) ========= 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=00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015795 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.770047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:58.770424) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4553ad09496a74d6d613d60ceefc22367cd4ee9b --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 4553ad09496a74d6d613d60ceefc22367cd4ee9b --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=00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 23:35:58,910 truncating revision to first 12 chars 2016-07-19 23:35:58,910 Setting DEBUG logging. 2016-07-19 23:35:58,910 attempt 1/10 2016-07-19 23:35:58,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4553ad09496a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 23:35:59,225 unpacking tar archive at: fx-team-4553ad09496a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675678 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:59.459567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:59.459872) ========= script_repo_revision: 4553ad09496a74d6d613d60ceefc22367cd4ee9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:59.460258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:59.460538) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 23:35:59.470473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-19 23:35:59.470848) ========= /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=00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:35:59 INFO - MultiFileLogger online at 20160719 23:35:59 in /builds/slave/test 23:35:59 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:35:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:35:59 INFO - {'append_to_log': False, 23:35:59 INFO - 'base_work_dir': '/builds/slave/test', 23:35:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:35:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:35:59 INFO - 'branch': 'Fx-Team-Non-PGO', 23:35:59 INFO - 'buildbot_json_path': 'buildprops.json', 23:35:59 INFO - 'config_files': ('talos/linux_config.py',), 23:35:59 INFO - 'default_actions': ('clobber', 23:35:59 INFO - 'read-buildbot-config', 23:35:59 INFO - 'download-and-extract', 23:35:59 INFO - 'populate-webroot', 23:35:59 INFO - 'create-virtualenv', 23:35:59 INFO - 'install', 23:35:59 INFO - 'run-tests'), 23:35:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:35:59 INFO - 'download_minidump_stackwalk': True, 23:35:59 INFO - 'download_symbols': 'ondemand', 23:35:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:35:59 INFO - 'tooltool.py': '/tools/tooltool.py', 23:35:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:35:59 INFO - '/tools/misc-python/virtualenv.py')}, 23:35:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:35:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:35:59 INFO - 'installer_path': 'installer.exe', 23:35:59 INFO - 'log_level': 'info', 23:35:59 INFO - 'log_name': 'talos', 23:35:59 INFO - 'log_to_console': True, 23:35:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:35:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:35:59 INFO - 'opt_config_files': (), 23:35:59 INFO - 'pip_index': False, 23:35:59 INFO - 'sps_profile': False, 23:35:59 INFO - 'sps_profile_interval': 0, 23:35:59 INFO - 'suite': 'dromaeojs', 23:35:59 INFO - 'system_bits': '32', 23:35:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:35:59 INFO - 'title': 'talos-linux64-ix-016', 23:35:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:35:59 INFO - 'use_talos_json': True, 23:35:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:35:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:35:59 INFO - 'work_dir': 'build'} 23:35:59 INFO - ##### 23:35:59 INFO - ##### Running clobber step. 23:35:59 INFO - ##### 23:35:59 INFO - Running pre-action listener: _resource_record_pre_action 23:35:59 INFO - Running main action method: clobber 23:35:59 INFO - rmtree: /builds/slave/test/build 23:35:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:36:00 INFO - Running post-action listener: _resource_record_post_action 23:36:00 INFO - ##### 23:36:00 INFO - ##### Finished clobber step (success) 23:36:00 INFO - ##### 23:36:00 INFO - ##### 23:36:00 INFO - ##### Running read-buildbot-config step. 23:36:00 INFO - ##### 23:36:00 INFO - Running pre-action listener: _resource_record_pre_action 23:36:00 INFO - Running main action method: read_buildbot_config 23:36:00 INFO - Using buildbot properties: 23:36:00 INFO - { 23:36:00 INFO - "project": "", 23:36:00 INFO - "product": "firefox", 23:36:00 INFO - "script_repo_revision": "production", 23:36:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:36:00 INFO - "repository": "", 23:36:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 23:36:00 INFO - "buildid": "20160719230124", 23:36:00 INFO - "pgo_build": "False", 23:36:00 INFO - "basedir": "/builds/slave/test", 23:36:00 INFO - "buildnumber": 3182, 23:36:00 INFO - "slavename": "talos-linux64-ix-016", 23:36:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:36:00 INFO - "platform": "ubuntu64_hw", 23:36:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:36:00 INFO - "branch": "fx-team", 23:36:00 INFO - "repo_path": "integration/fx-team", 23:36:00 INFO - "revision": "4553ad09496a74d6d613d60ceefc22367cd4ee9b", 23:36:00 INFO - "stage_platform": "linux64", 23:36:00 INFO - "builduid": "1f77a000c9c749cd9d7d76be7f0a3eab", 23:36:00 INFO - "slavebuilddir": "test" 23:36:00 INFO - } 23:36:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:36:00 INFO - Running post-action listener: _resource_record_post_action 23:36:00 INFO - ##### 23:36:00 INFO - ##### Finished read-buildbot-config step (success) 23:36:00 INFO - ##### 23:36:00 INFO - ##### 23:36:00 INFO - ##### Running download-and-extract step. 23:36:00 INFO - ##### 23:36:00 INFO - Running pre-action listener: _resource_record_pre_action 23:36:00 INFO - Running main action method: download_and_extract 23:36:00 INFO - mkdir: /builds/slave/test/build/tests 23:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:00 INFO - https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:36:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:01 INFO - Downloaded 1361 bytes. 23:36:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:01 INFO - Using the following test package requirements: 23:36:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:36:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:36:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'jsshell-linux-x86_64.zip'], 23:36:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:36:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:36:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:36:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:36:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:36:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:36:01 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:36:01 INFO - https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:02 INFO - Downloaded 22763363 bytes. 23:36:02 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:36:02 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:36:03 INFO - Return code: 0 23:36:03 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:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:03 INFO - https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:04 INFO - Downloaded 22763363 bytes. 23:36:04 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:36:04 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:36:05 INFO - Return code: 0 23:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:05 INFO - https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:07 INFO - Downloaded 14403317 bytes. 23:36:07 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:36:07 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:36:08 INFO - Return code: 0 23:36: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:36:08 INFO - https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:36:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXonckjWT4C4faJnnTUnQA/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:36:10 INFO - Downloaded 57122020 bytes. 23:36:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:10 INFO - mkdir: /builds/slave/test/properties 23:36:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:36:10 INFO - Writing to file /builds/slave/test/properties/build_url 23:36:10 INFO - Contents: 23:36:10 INFO - build_url:https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:11 INFO - Running post-action listener: _resource_record_post_action 23:36:11 INFO - Running post-action listener: set_extra_try_arguments 23:36:11 INFO - ##### 23:36:11 INFO - ##### Finished download-and-extract step (success) 23:36:11 INFO - ##### 23:36:11 INFO - ##### 23:36:11 INFO - ##### Running populate-webroot step. 23:36:11 INFO - ##### 23:36:11 INFO - Running pre-action listener: _resource_record_pre_action 23:36:11 INFO - Running main action method: populate_webroot 23:36:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:36:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:36:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:36:11 INFO - '--tppagecycles', 23:36:11 INFO - '7'], 23:36:11 INFO - 'tests': ['tsvgm']}}, 23:36:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:36:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:36:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:36:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:36:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['damp', 'tps']}, 23:36:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'tests': ['damp', 'tps']}, 23:36:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['dromaeo_dom']}, 23:36:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:36:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['basic_compositor_video']}, 23:36:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:36:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['a11yr', 23:36:11 INFO - 'ts_paint', 23:36:11 INFO - 'tpaint', 23:36:11 INFO - 'sessionrestore', 23:36:11 INFO - 'sessionrestore_no_auto_restore', 23:36:11 INFO - 'tabpaint']}, 23:36:11 INFO - 'other-e10s': {'tests': ['a11yr', 23:36:11 INFO - 'ts_paint', 23:36:11 INFO - 'tpaint', 23:36:11 INFO - 'sessionrestore', 23:36:11 INFO - 'sessionrestore_no_auto_restore', 23:36:11 INFO - 'tabpaint']}, 23:36:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:36:11 INFO - 'ts_paint', 23:36:11 INFO - 'tpaint', 23:36:11 INFO - 'sessionrestore', 23:36:11 INFO - 'sessionrestore_no_auto_restore', 23:36:11 INFO - 'tabpaint']}, 23:36:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:36:11 INFO - 'ts_paint', 23:36:11 INFO - 'tpaint', 23:36:11 INFO - 'sessionrestore', 23:36:11 INFO - 'sessionrestore_no_auto_restore', 23:36:11 INFO - 'tabpaint']}, 23:36:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['a11yr', 23:36:11 INFO - 'ts_paint', 23:36:11 INFO - 'tpaint', 23:36:11 INFO - 'sessionrestore', 23:36:11 INFO - 'sessionrestore_no_auto_restore', 23:36:11 INFO - 'tabpaint']}, 23:36:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['a11yr', 23:36:11 INFO - 'ts_paint', 23:36:11 INFO - 'tpaint', 23:36:11 INFO - 'sessionrestore', 23:36:11 INFO - 'sessionrestore_no_auto_restore', 23:36:11 INFO - 'tabpaint']}, 23:36:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['tsvgx', 23:36:11 INFO - 'tsvgr_opacity', 23:36:11 INFO - 'tart', 23:36:11 INFO - 'tscrollx', 23:36:11 INFO - 'cart']}, 23:36:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:36:11 INFO - 'tsvgr_opacity', 23:36:11 INFO - 'tart', 23:36:11 INFO - 'tscrollx', 23:36:11 INFO - 'cart']}, 23:36:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'talos_options': ['--disable-e10s'], 23:36:11 INFO - 'tests': ['tp5o']}, 23:36:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'tests': ['tp5o']}, 23:36:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'talos_options': ['--disable-e10s', 23:36:11 INFO - '--xperf_path', 23:36:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:11 INFO - 'tests': ['tp5n']}, 23:36:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:11 INFO - 'talos_options': ['--xperf_path', 23:36:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:11 INFO - 'tests': ['tp5n']}}, 23:36:11 INFO - 'talos.zip': {'path': '', 23:36:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:36:11 INFO - Running post-action listener: _resource_record_post_action 23:36:11 INFO - ##### 23:36:11 INFO - ##### Finished populate-webroot step (success) 23:36:11 INFO - ##### 23:36:11 INFO - ##### 23:36:11 INFO - ##### Running create-virtualenv step. 23:36:11 INFO - ##### 23:36:11 INFO - Running pre-action listener: _resource_record_pre_action 23:36:11 INFO - Running main action method: create_virtualenv 23:36:11 INFO - Creating virtualenv /builds/slave/test/build/venv 23:36:11 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:36:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:36:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:36:11 INFO - Using real prefix '/usr' 23:36:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:36:11 INFO - Installing distribute.............................................................................................................................................................................................done. 23:36:13 INFO - Installing pip.................done. 23:36:13 INFO - Return code: 0 23:36:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:36: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:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36: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:36: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:36:13 INFO - Using env: {'DISPLAY': ':0', 23:36:13 INFO - 'HOME': '/home/cltbld', 23:36:13 INFO - 'LANG': 'en_US.UTF-8', 23:36:13 INFO - 'LANGUAGE': 'en_US:en', 23:36:13 INFO - 'LOGNAME': 'cltbld', 23:36:13 INFO - 'MAIL': '/var/mail/cltbld', 23:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:13 INFO - 'MOZ_NO_REMOTE': '1', 23:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:13 INFO - 'NO_EM_RESTART': '1', 23:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:13 INFO - 'PWD': '/builds/slave/test', 23:36:13 INFO - 'SHELL': '/bin/bash', 23:36:13 INFO - 'SHLVL': '1', 23:36:13 INFO - 'TERM': 'linux', 23:36:13 INFO - 'TMOUT': '86400', 23:36:13 INFO - 'USER': 'cltbld', 23:36:13 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:13 INFO - '_': '/tools/buildbot/bin/python'} 23:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:14 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:36:14 INFO - Cleaning up... 23:36:14 INFO - Return code: 0 23:36:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:36:14 INFO - Using env: {'DISPLAY': ':0', 23:36:14 INFO - 'HOME': '/home/cltbld', 23:36:14 INFO - 'LANG': 'en_US.UTF-8', 23:36:14 INFO - 'LANGUAGE': 'en_US:en', 23:36:14 INFO - 'LOGNAME': 'cltbld', 23:36:14 INFO - 'MAIL': '/var/mail/cltbld', 23:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:14 INFO - 'MOZ_NO_REMOTE': '1', 23:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:14 INFO - 'NO_EM_RESTART': '1', 23:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:14 INFO - 'PWD': '/builds/slave/test', 23:36:14 INFO - 'SHELL': '/bin/bash', 23:36:14 INFO - 'SHLVL': '1', 23:36:14 INFO - 'TERM': 'linux', 23:36:14 INFO - 'TMOUT': '86400', 23:36:14 INFO - 'USER': 'cltbld', 23:36:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:14 INFO - '_': '/tools/buildbot/bin/python'} 23:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:14 INFO - Downloading/unpacking psutil>=3.1.1 23:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:36:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:16 INFO - Installing collected packages: psutil 23:36:16 INFO - Running setup.py install for psutil 23:36:16 INFO - building 'psutil._psutil_linux' extension 23:36:16 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:36: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:36:16 INFO - building 'psutil._psutil_posix' extension 23:36:16 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:36: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:36:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:16 INFO - Successfully installed psutil 23:36:16 INFO - Cleaning up... 23:36:16 INFO - Return code: 0 23:36:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:36: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:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36: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:36: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:36:16 INFO - Using env: {'DISPLAY': ':0', 23:36:16 INFO - 'HOME': '/home/cltbld', 23:36:16 INFO - 'LANG': 'en_US.UTF-8', 23:36:16 INFO - 'LANGUAGE': 'en_US:en', 23:36:16 INFO - 'LOGNAME': 'cltbld', 23:36:16 INFO - 'MAIL': '/var/mail/cltbld', 23:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:16 INFO - 'MOZ_NO_REMOTE': '1', 23:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:16 INFO - 'NO_EM_RESTART': '1', 23:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:16 INFO - 'PWD': '/builds/slave/test', 23:36:16 INFO - 'SHELL': '/bin/bash', 23:36:16 INFO - 'SHLVL': '1', 23:36:16 INFO - 'TERM': 'linux', 23:36:16 INFO - 'TMOUT': '86400', 23:36:16 INFO - 'USER': 'cltbld', 23:36:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:16 INFO - '_': '/tools/buildbot/bin/python'} 23:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:36:17 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:36:17 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:36:17 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:36:17 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:36:17 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:36:17 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:36:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:36: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:36:18 INFO - Installing collected packages: mozsystemmonitor 23:36:18 INFO - Running setup.py install for mozsystemmonitor 23:36:19 INFO - Successfully installed mozsystemmonitor 23:36:19 INFO - Cleaning up... 23:36:19 INFO - Return code: 0 23:36:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:36:19 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:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:19 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:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:19 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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36:19 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:36:19 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:36:19 INFO - Using env: {'DISPLAY': ':0', 23:36:19 INFO - 'HOME': '/home/cltbld', 23:36:19 INFO - 'LANG': 'en_US.UTF-8', 23:36:19 INFO - 'LANGUAGE': 'en_US:en', 23:36:19 INFO - 'LOGNAME': 'cltbld', 23:36:19 INFO - 'MAIL': '/var/mail/cltbld', 23:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:19 INFO - 'MOZ_NO_REMOTE': '1', 23:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:19 INFO - 'NO_EM_RESTART': '1', 23:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:19 INFO - 'PWD': '/builds/slave/test', 23:36:19 INFO - 'SHELL': '/bin/bash', 23:36:19 INFO - 'SHLVL': '1', 23:36:19 INFO - 'TERM': 'linux', 23:36:19 INFO - 'TMOUT': '86400', 23:36:19 INFO - 'USER': 'cltbld', 23:36:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:19 INFO - '_': '/tools/buildbot/bin/python'} 23:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:19 INFO - Downloading/unpacking jsonschema==2.5.1 23:36:19 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:36:19 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:36:19 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:36:19 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:36:19 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:36:19 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:36:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:36:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:36: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:36: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:36: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:36: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:36: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:36: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:36:21 INFO - Downloading functools32-3.2.3-2.tar.gz 23:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:36:21 INFO - warning: no files found matching '*.txt' 23:36:21 INFO - no previously-included directories found matching 'build' 23:36:21 INFO - no previously-included directories found matching 'dist' 23:36:21 INFO - no previously-included directories found matching '.git*' 23:36:21 INFO - Installing collected packages: jsonschema, functools32 23:36:21 INFO - Running setup.py install for functools32 23:36:21 INFO - warning: no files found matching '*.txt' 23:36:21 INFO - no previously-included directories found matching 'build' 23:36:21 INFO - no previously-included directories found matching 'dist' 23:36:21 INFO - no previously-included directories found matching '.git*' 23:36:21 INFO - Successfully installed jsonschema functools32 23:36:21 INFO - Cleaning up... 23:36:21 INFO - Return code: 0 23:36:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:36: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:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36: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:36: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:36:21 INFO - Using env: {'DISPLAY': ':0', 23:36:21 INFO - 'HOME': '/home/cltbld', 23:36:21 INFO - 'LANG': 'en_US.UTF-8', 23:36:21 INFO - 'LANGUAGE': 'en_US:en', 23:36:21 INFO - 'LOGNAME': 'cltbld', 23:36:21 INFO - 'MAIL': '/var/mail/cltbld', 23:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:21 INFO - 'MOZ_NO_REMOTE': '1', 23:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:21 INFO - 'NO_EM_RESTART': '1', 23:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:21 INFO - 'PWD': '/builds/slave/test', 23:36:21 INFO - 'SHELL': '/bin/bash', 23:36:21 INFO - 'SHLVL': '1', 23:36:21 INFO - 'TERM': 'linux', 23:36:21 INFO - 'TMOUT': '86400', 23:36:21 INFO - 'USER': 'cltbld', 23:36:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:21 INFO - '_': '/tools/buildbot/bin/python'} 23:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:21 INFO - Downloading/unpacking blobuploader==1.2.4 23:36: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:36: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:36: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:36: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:36: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:36: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:36:23 INFO - Downloading blobuploader-1.2.4.tar.gz 23:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:36:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:36: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:36: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:36: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:36: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:36: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:36: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:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:36:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:36:24 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:36:24 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:36:24 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:36:24 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:36:24 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:36:24 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:36:24 INFO - Downloading docopt-0.6.1.tar.gz 23:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:36:24 INFO - Installing collected packages: blobuploader, requests, docopt 23:36:24 INFO - Running setup.py install for blobuploader 23:36:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:36:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:36:24 INFO - Running setup.py install for requests 23:36:25 INFO - Running setup.py install for docopt 23:36:25 INFO - Successfully installed blobuploader requests docopt 23:36:25 INFO - Cleaning up... 23:36:25 INFO - Return code: 0 23:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:25 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:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:25 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:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:25 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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36:25 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:36:25 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:36:25 INFO - Using env: {'DISPLAY': ':0', 23:36:25 INFO - 'HOME': '/home/cltbld', 23:36:25 INFO - 'LANG': 'en_US.UTF-8', 23:36:25 INFO - 'LANGUAGE': 'en_US:en', 23:36:25 INFO - 'LOGNAME': 'cltbld', 23:36:25 INFO - 'MAIL': '/var/mail/cltbld', 23:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:25 INFO - 'MOZ_NO_REMOTE': '1', 23:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:25 INFO - 'NO_EM_RESTART': '1', 23:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:25 INFO - 'PWD': '/builds/slave/test', 23:36:25 INFO - 'SHELL': '/bin/bash', 23:36:25 INFO - 'SHLVL': '1', 23:36:25 INFO - 'TERM': 'linux', 23:36:25 INFO - 'TMOUT': '86400', 23:36:25 INFO - 'USER': 'cltbld', 23:36:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:25 INFO - '_': '/tools/buildbot/bin/python'} 23:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:25 INFO - Running setup.py (path:/tmp/pip-h1ZpnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:25 INFO - Running setup.py (path:/tmp/pip-dvxEry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:25 INFO - Running setup.py (path:/tmp/pip-Gbjo6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:25 INFO - Running setup.py (path:/tmp/pip-FNgMCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:25 INFO - Running setup.py (path:/tmp/pip-5g1dlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:25 INFO - Running setup.py (path:/tmp/pip-5_SiCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:25 INFO - Running setup.py (path:/tmp/pip-LftmRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:25 INFO - Running setup.py (path:/tmp/pip-HdlEAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:26 INFO - Running setup.py (path:/tmp/pip-veShwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:26 INFO - Running setup.py (path:/tmp/pip-UgRfv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:26 INFO - Running setup.py (path:/tmp/pip-HeBLcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:26 INFO - Running setup.py (path:/tmp/pip-WlT_sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:26 INFO - Running setup.py (path:/tmp/pip-AiYnYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:26 INFO - Running setup.py (path:/tmp/pip-vPV24t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:26 INFO - Running setup.py (path:/tmp/pip-75XsPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:26 INFO - Running setup.py (path:/tmp/pip-lo6XG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:26 INFO - Running setup.py (path:/tmp/pip-PvQ39D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:36:26 INFO - Running setup.py install for manifestparser 23:36:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:36:26 INFO - Running setup.py install for mozcrash 23:36:26 INFO - Running setup.py install for mozdebug 23:36:26 INFO - Running setup.py install for mozdevice 23:36:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Running setup.py install for mozfile 23:36:27 INFO - Running setup.py install for mozhttpd 23:36:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Running setup.py install for mozinfo 23:36:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Running setup.py install for mozInstall 23:36:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Running setup.py install for mozleak 23:36:27 INFO - Running setup.py install for mozlog 23:36:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Running setup.py install for moznetwork 23:36:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Running setup.py install for mozprocess 23:36:27 INFO - Running setup.py install for mozprofile 23:36:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:36:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:36:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:36:28 INFO - Running setup.py install for mozrunner 23:36:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:36:28 INFO - Running setup.py install for mozscreenshot 23:36:28 INFO - Running setup.py install for moztest 23:36:28 INFO - Running setup.py install for mozversion 23:36:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:36:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:36:28 INFO - Cleaning up... 23:36:28 INFO - Return code: 0 23:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:28 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:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:28 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:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:28 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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36:28 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:36:28 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:36:28 INFO - Using env: {'DISPLAY': ':0', 23:36:28 INFO - 'HOME': '/home/cltbld', 23:36:28 INFO - 'LANG': 'en_US.UTF-8', 23:36:28 INFO - 'LANGUAGE': 'en_US:en', 23:36:28 INFO - 'LOGNAME': 'cltbld', 23:36:28 INFO - 'MAIL': '/var/mail/cltbld', 23:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:28 INFO - 'MOZ_NO_REMOTE': '1', 23:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:28 INFO - 'NO_EM_RESTART': '1', 23:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:28 INFO - 'PWD': '/builds/slave/test', 23:36:28 INFO - 'SHELL': '/bin/bash', 23:36:28 INFO - 'SHLVL': '1', 23:36:28 INFO - 'TERM': 'linux', 23:36:28 INFO - 'TMOUT': '86400', 23:36:28 INFO - 'USER': 'cltbld', 23:36:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:28 INFO - '_': '/tools/buildbot/bin/python'} 23:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:28 INFO - Running setup.py (path:/tmp/pip-Ewdtj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36: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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:28 INFO - Running setup.py (path:/tmp/pip-9k6BVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36: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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:28 INFO - Running setup.py (path:/tmp/pip-tEFKhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36: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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:28 INFO - Running setup.py (path:/tmp/pip-iu5xKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36: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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:28 INFO - Running setup.py (path:/tmp/pip-yuxk9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:29 INFO - Running setup.py (path:/tmp/pip-g6lF24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:29 INFO - Running setup.py (path:/tmp/pip-nxKu_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:29 INFO - Running setup.py (path:/tmp/pip-5UosFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:29 INFO - Running setup.py (path:/tmp/pip-NJxbp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:29 INFO - Running setup.py (path:/tmp/pip-7ftWaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:29 INFO - Running setup.py (path:/tmp/pip-O4syYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:29 INFO - Running setup.py (path:/tmp/pip-if19aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:29 INFO - Running setup.py (path:/tmp/pip-Bq7VSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:29 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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:29 INFO - Running setup.py (path:/tmp/pip-UBwols-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:29 INFO - Running setup.py (path:/tmp/pip-2ozjSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36: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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:29 INFO - Running setup.py (path:/tmp/pip-sduR9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36: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:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:29 INFO - Running setup.py (path:/tmp/pip-A2QM2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36: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:36: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:36: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:36: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:36: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:36: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:36:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:36: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:36: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:36: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:36: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:36: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:36: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:36:31 INFO - Downloading blessings-1.6.tar.gz 23:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:36:31 INFO - Installing collected packages: blessings 23:36:31 INFO - Running setup.py install for blessings 23:36:32 INFO - Successfully installed blessings 23:36:32 INFO - Cleaning up... 23:36:32 INFO - Return code: 0 23:36:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:36:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:32 INFO - Reading from file tmpfile_stdout 23:36:32 INFO - Current package versions: 23:36:32 INFO - argparse == 1.2.1 23:36:32 INFO - blessings == 1.6 23:36:32 INFO - blobuploader == 1.2.4 23:36:32 INFO - docopt == 0.6.1 23:36:32 INFO - functools32 == 3.2.3-2 23:36:32 INFO - jsonschema == 2.5.1 23:36:32 INFO - manifestparser == 1.1 23:36:32 INFO - mozInstall == 1.12 23:36:32 INFO - mozcrash == 0.17 23:36:32 INFO - mozdebug == 0.1 23:36:32 INFO - mozdevice == 0.48 23:36:32 INFO - mozfile == 1.2 23:36:32 INFO - mozhttpd == 0.7 23:36:32 INFO - mozinfo == 0.9 23:36:32 INFO - mozleak == 0.1 23:36:32 INFO - mozlog == 3.2 23:36:32 INFO - moznetwork == 0.27 23:36:32 INFO - mozprocess == 0.23 23:36:32 INFO - mozprofile == 0.28 23:36:32 INFO - mozrunner == 6.12 23:36:32 INFO - mozscreenshot == 0.1 23:36:32 INFO - mozsystemmonitor == 0.3 23:36:32 INFO - moztest == 0.7 23:36:32 INFO - mozversion == 1.4 23:36:32 INFO - psutil == 3.1.1 23:36:32 INFO - requests == 1.2.3 23:36:32 INFO - wsgiref == 0.1.2 23:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36: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:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:32 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 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36:32 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:36:32 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:36:32 INFO - Using env: {'DISPLAY': ':0', 23:36:32 INFO - 'HOME': '/home/cltbld', 23:36:32 INFO - 'LANG': 'en_US.UTF-8', 23:36:32 INFO - 'LANGUAGE': 'en_US:en', 23:36:32 INFO - 'LOGNAME': 'cltbld', 23:36:32 INFO - 'MAIL': '/var/mail/cltbld', 23:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:32 INFO - 'MOZ_NO_REMOTE': '1', 23:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:32 INFO - 'NO_EM_RESTART': '1', 23:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:32 INFO - 'PWD': '/builds/slave/test', 23:36:32 INFO - 'SHELL': '/bin/bash', 23:36:32 INFO - 'SHLVL': '1', 23:36:32 INFO - 'TERM': 'linux', 23:36:32 INFO - 'TMOUT': '86400', 23:36:32 INFO - 'USER': 'cltbld', 23:36:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:32 INFO - '_': '/tools/buildbot/bin/python'} 23:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:32 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:36:32 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:36:32 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:36:32 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:36:32 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:36:32 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:36:32 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:36:32 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:36:32 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:36:32 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:36:32 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:36:32 INFO - Cleaning up... 23:36:32 INFO - Return code: 0 23:36:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:36: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:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, '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': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', '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:36: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', 'jsonschema'] in /builds/slave/test/build 23:36: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 jsonschema 23:36:32 INFO - Using env: {'DISPLAY': ':0', 23:36:32 INFO - 'HOME': '/home/cltbld', 23:36:32 INFO - 'LANG': 'en_US.UTF-8', 23:36:32 INFO - 'LANGUAGE': 'en_US:en', 23:36:32 INFO - 'LOGNAME': 'cltbld', 23:36:32 INFO - 'MAIL': '/var/mail/cltbld', 23:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:32 INFO - 'MOZ_NO_REMOTE': '1', 23:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:32 INFO - 'NO_EM_RESTART': '1', 23:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:32 INFO - 'PWD': '/builds/slave/test', 23:36:32 INFO - 'SHELL': '/bin/bash', 23:36:32 INFO - 'SHLVL': '1', 23:36:32 INFO - 'TERM': 'linux', 23:36:32 INFO - 'TMOUT': '86400', 23:36:32 INFO - 'USER': 'cltbld', 23:36:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:32 INFO - '_': '/tools/buildbot/bin/python'} 23:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:36:32 INFO - Cleaning up... 23:36:32 INFO - Return code: 0 23:36:32 INFO - Running post-action listener: _resource_record_post_action 23:36:32 INFO - Running post-action listener: _start_resource_monitoring 23:36:32 INFO - Starting resource monitoring. 23:36:32 INFO - ##### 23:36:32 INFO - ##### Finished create-virtualenv step (success) 23:36:32 INFO - ##### 23:36:32 INFO - ##### 23:36:32 INFO - ##### Running install step. 23:36:32 INFO - ##### 23:36:32 INFO - Running pre-action listener: _resource_record_pre_action 23:36:32 INFO - Running main action method: install 23:36:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:33 INFO - Reading from file tmpfile_stdout 23:36:33 INFO - Detecting whether we're running mozinstall >=1.0... 23:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:36:33 INFO - Reading from file tmpfile_stdout 23:36:33 INFO - Output received: 23:36:33 INFO - Usage: mozinstall [options] installer 23:36:33 INFO - Options: 23:36:33 INFO - -h, --help show this help message and exit 23:36:33 INFO - -d DEST, --destination=DEST 23:36:33 INFO - Directory to install application into. [default: 23:36:33 INFO - "/builds/slave/test"] 23:36:33 INFO - --app=APP Application being installed. [default: firefox] 23:36:33 INFO - mkdir: /builds/slave/test/build/application 23:36:33 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:36:33 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:36:49 INFO - Reading from file tmpfile_stdout 23:36:49 INFO - Output received: 23:36:49 INFO - /builds/slave/test/build/application/firefox/firefox 23:36:49 INFO - Running post-action listener: _resource_record_post_action 23:36:49 INFO - ##### 23:36:49 INFO - ##### Finished install step (success) 23:36:49 INFO - ##### 23:36:49 INFO - ##### 23:36:49 INFO - ##### Running run-tests step. 23:36:49 INFO - ##### 23:36:49 INFO - Running pre-action listener: _resource_record_pre_action 23:36:49 INFO - Running main action method: run_tests 23:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:36:49 INFO - Python 2.7.3 23:36:49 INFO - Return code: 0 23:36:49 INFO - grabbing minidump binary from tooltool 23:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:49 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 0x20b93b0>, '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 0x20ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ba740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:36:49 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:36:49 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:36:49 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:36:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:36:49 INFO - Return code: 0 23:36:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:36:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:36:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:36:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:36:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:36:49 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/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:36:49 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/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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:36:49 INFO - Using env: {'DISPLAY': ':0', 23:36:49 INFO - 'HOME': '/home/cltbld', 23:36:49 INFO - 'LANG': 'en_US.UTF-8', 23:36:49 INFO - 'LANGUAGE': 'en_US:en', 23:36:49 INFO - 'LOGNAME': 'cltbld', 23:36:49 INFO - 'MAIL': '/var/mail/cltbld', 23:36:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:36:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:49 INFO - 'MOZ_NO_REMOTE': '1', 23:36:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:49 INFO - 'NO_EM_RESTART': '1', 23:36:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:49 INFO - 'PWD': '/builds/slave/test', 23:36:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:36:49 INFO - 'SHELL': '/bin/bash', 23:36:49 INFO - 'SHLVL': '1', 23:36:49 INFO - 'TERM': 'linux', 23:36:49 INFO - 'TMOUT': '86400', 23:36:49 INFO - 'USER': 'cltbld', 23:36:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212', 23:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:49 INFO - '_': '/tools/buildbot/bin/python'} 23:36:49 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/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:36:49 INFO - mozversion application_buildid: 20160719230124 23:36:49 INFO - mozversion application_changeset: 4553ad09496a74d6d613d60ceefc22367cd4ee9b 23:36:49 INFO - mozversion application_display_name: Nightly 23:36:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:36:49 INFO - mozversion application_name: Firefox 23:36:49 INFO - mozversion application_remotingname: firefox 23:36:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:36:49 INFO - mozversion application_vendor: Mozilla 23:36:49 INFO - mozversion application_version: 50.0a1 23:36:49 INFO - mozversion platform_buildid: 20160719230124 23:36:49 INFO - mozversion platform_changeset: 4553ad09496a74d6d613d60ceefc22367cd4ee9b 23:36:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:36:49 INFO - mozversion platform_version: 50.0a1 23:36:49 INFO - using testdate: 1468996609 23:36:49 INFO - actual date: 1468996609 23:36:49 INFO - starting webserver on 'localhost:41680' 23:36:49 INFO - SUITE-START | Running 2 tests 23:36:49 INFO - TEST-START | dromaeo_css 23:36:49 INFO - operating with platform_type : linux_ 23:36:49 INFO - Initialising browser for dromaeo_css test... 23:36:49 INFO - TEST-INFO | started process 11302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsvz234/profile http://localhost:41680/getInfo.html) 23:36:54 INFO - PROCESS | 11302 | __metrics Screen width/height:1600/1200 23:36:54 INFO - PROCESS | 11302 | colorDepth:24 23:36:54 INFO - PROCESS | 11302 | Browser inner width/height: 1024/697 23:36:54 INFO - PROCESS | 11302 | __metrics 23:36:54 INFO - PROCESS | 11302 | 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:36:54 INFO - PROCESS | 11302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:36:55 INFO - TEST-INFO | 11302: exit 0 23:36:55 INFO - Browser initialized. 23:36:55 INFO - Running cycle 1/1 for dromaeo_css test... 23:36:55 INFO - TEST-INFO | started process 11385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsvz234/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:07 INFO - PROCESS | 11385 | RSS: Main: 159498240 23:37:07 INFO - PROCESS | 11385 | 23:37:58 INFO - PROCESS | 11385 | 1468996678742 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:40:11 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:41680/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41680/tests/dromaeo/cssquery-ext.html) 23:40:12 INFO - PROCESS | 11385 | RSS: Main: 283250688 23:40:12 INFO - PROCESS | 11385 | 23:43:15 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:41680/tests/dromaeo/cssquery-ext.html (next: http://localhost:41680/tests/dromaeo/cssquery-jquery.html) 23:43:16 INFO - PROCESS | 11385 | RSS: Main: 239067136 23:43:16 INFO - PROCESS | 11385 | 23:46:18 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:41680/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41680/tests/dromaeo/cssquery-mootools.html) 23:46:18 INFO - PROCESS | 11385 | RSS: Main: 244465664 23:46:18 INFO - PROCESS | 11385 | 23:49:21 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:41680/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41680/tests/dromaeo/cssquery-prototype.html) 23:49:21 INFO - PROCESS | 11385 | RSS: Main: 243957760 23:49:21 INFO - PROCESS | 11385 | 23:52:24 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:41680/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41680/tests/dromaeo/cssquery-yui.html) 23:52:25 INFO - PROCESS | 11385 | RSS: Main: 215060480 23:52:25 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:41680/tests/dromaeo/cssquery-yui.html (next: http://localhost:41680/tests/dromaeo/cssquery-dojo.html) 23:55:28 INFO - PROCESS | 11385 | RSS: Main: 281493504 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | __start_tp_report 23:55:28 INFO - PROCESS | 11385 | _x_x_mozilla_page_load 23:55:28 INFO - PROCESS | 11385 | _x_x_mozilla_page_load_details 23:55:28 INFO - PROCESS | 11385 | |i|pagename|runs| 23:55:28 INFO - PROCESS | 11385 | |0;dojo.html;2603.7526434988677;2611.608258761187;2640.102365195833;2668.973310266898;2674.1576403432928;4568.931466028012;4621.214393553096;4684.086603112394;4704.411948506437;4719.339292499053;4592.816287348511;4593.770311484421;4613.9077218455695;4635.374224479694;4641.559051890065;4015.297322968469;4186.162767446508;4278.058827058042;4315.050688848449;4328.502222244435;4207.410962465257;4299.462567179103;4304.548022457629;4305.4833419989645;4337.349397590355;4228.788560571959;4276.251655960225;4281.892952676177;4286.592773686526;4332.415123958257;4268.59448352406;4280.807363668642;4327.3725309830215;4341.500727416356;4353.281708518122;4332.653387728974;4336.1978034063795;4337;4358;4360.6293465055505;4569.428821397325;4609.055143695535;4686.742229177394;4689.413823272091;4712.034033023222;4993.650444468889;5012.373453318335;5019.698818070928;5038.244263360489;5053.444121146671;4971.950280497185;5066.341375621146;5104.157813960692;5113.437521872591;5114;4721.220998535237;4771.045790841846;4773.140834649727;4802.567768900746;4819;5240.030594340059;5267.578593712494;5270.657407268515;5280.128778751463;5282.366116066097;4745.667803253739;4780.067886762048;5007.7245751484015;5055.9494405055475;5063;4890.413150421972;4911.607071434277;4929.0388374267395;4957.752112394366;4983.377077865267;4927.162382395001;4928.260760885896;4931.457539670633;4933.802647894044;4983.825566105242;4848.878778030577;4880.389951256093;4915.336429582032;4916.385451818523;4923.975380123076;4293.957060429419;4300.78496075195;4309;4351.477822661301;4355.477342718894;3728.7389882708494;3732.701383889282;3751.0809851586537;3771.773693578394;3784.9810750946067;4238.978805106017;4266.722663026893;4293.3989241506215;4323.113761678848;4324.17840610283;4963.90072198554;4998.525140111684;4999.625028122905;5003.3495645565845;5039.622028347815;4299.290617048215;4301.784910754513;4303.182395344875;4318.935215971763;4345.717528360647;4473.530279320689;4494.617957473652;4528.252838281713;4535.886602834889;4541.863744087683;4695.0375173090115;4719.8112075517965;4726.291056341576;4767.33257343979;4778.37881075458;5013.899722005613;5017.8243761468175;5023.372078490189;5027;5066.746662666926;4580.725156490621;4677.345171676036;4704.929426058543;4727.3381726559;4750.691205071659;4961.107000739901;4972.378452693413;4982;4984.252362145708;5035.748212589283;5021;5035.84892453227;5040.218766091261;5042.243663450512;5092.643514954066;4797.784099715452;4823.324734537237;4844.346013288161;4854.053459575349;4919.3604831371695;4916.729579873141;4953.430355509018;4955.6531042826655;4961.8015279389865;5009.348784657971;4877.268409738425;4885.87785305356;4886.902261954812;4888.1690112681645;4933.309336692938;4798.928016079692;4834.3231947528075;4897.95102048975;4935.580475659609;4940.407151141886;4846.466888642176;4857.198562237191;4860.246661767432;4883.340748998839;4905.386826646669 23:55:28 INFO - PROCESS | 11385 | |1;ext.html;570.3839852958804;584.4126652714021;593.1310629927159;603.1917230910578;605.8000859716294;27393.58909616355;38945.61054389455;40078;40443.797781011126;44638.33042504357;41428;41736.37395439071;41835.372469412985;41863;41909.371359429635;7507.549547027169;7779.766607001785;7892.447528672995;7926.643301051467;7931;7636.541807491568;7759.7672069838;7765.922340776577;9965.302428829984;10250.282480226388;10266.38401695897;10346.22403319754;10352.5341359639;10353.689389318333;10363.533640986136;10173.796524069514;10216.591336346537;10245.129164021067;10249.33379330341;10258.17934565233;7604;9953.75115622108;10326.535305911251;10327.431991240479;10626.628068017659;39083.41374879379;39314.21371572553;39532;39532.802335988425;39536;3056.404001219763;3067.2638566744045;3289.4407950648206;3685.68671662909;3711.888643340704;28891.422171556453;28990.855045724846;29013.56479652807;29470.26324341887;29570.260743481584;3457.567804024497;3477.8087205203706;3505.106197919514;3528.788272703646;3571.8392672329805;184037.99999999866;184392;184889;184897;185339;31512.684873151433;52913.735431323366;53195.73402132965;53284;53329;31833;34185.31629367399;34274.65725342715;34285.14287142841;34336;14162;14284.285785710674;14377.56867293983;14383.856161438462;14389.568312950629;10679.78640427187;11909.642710718692;12037.638870833889;12050.758984820255;12057.336846473352;7761.068671759312;7984.121746607869;7993.240642138988;8057.677692892219;8122.106568277485;3086.1667349815425;3130.3269796993754;3136.8902088427253;3140.98429507851;3180.538821870862;835.1439774231461;973.0755782007121;998.9051040151319;1007.471077684207;1023.7952409518126;28159.859200703864;28293.858530707214;28310.43379132447;28393.71606283952;28487.857560712062;944.6882528765491;953.2374100719396;966.5988614724951;980.7695191629962;1063.0326402973258;14843.183624900734;14983.250837458301;15096.698066038618;15219.923900380649;15250.468805181034;391663;393633;396583;397026;398495;50046;50458;50566.74716626394;50676.493235067916;50682;1077.7359546911057;1156.988430115688;1173.884809431044;1202.506972141418;1212.1333246728632;27878.860605696842;29296.560551591316;29298.853505732335;29386.853065734533;29600.703992959796;41558;42010.78994605008;42020.529281475;42033;42120.578794211666;298097;303102;303435;303475;304497;22159.446013849138;22545.549089018456;22612.773872261067;23634.88182559076;23890.40273993164;34422.48366274558;34856.12859678528;41366.1726765469;42118.57881421269;47183;34870.47694284537;35956.4606530897;36665.45001825028;37369.4394584076;37446.812765935996;36366;36366;36742.81628591947;37174.25651487009;37351.62648373481;35423.46864797082;35490;35703.28593428169;36098.27803443864;36242;31940;32124.518132228503;32499.512507312884;32583.674163258063;33014.5047824278;25091.24726258215;25186;25518;25568.48863022692;25594.48811023732 23:55:28 INFO - PROCESS | 11385 | |2;jquery.html;368.77504722119505;369.59344720807115;370.98516059357627;385.97298189126775;387.5330227076373;16361.918190409046;17303.134843257834;18153.81846181538;18162.818371816276;18178.909105454455;11474.655760327183;16001.27994240259;16705.916470417662;16787.83212167878;17579.85730927492;4626.791794369253;4768.7138771673635;4822;4827.879303017417;4828.46886842447;3487.354839354715;3676.466912297715;5213.791448342062;5477.287952566161;5493.038718224295;5510.1459273812625;5519.31008623922;5521.337439507265;5527.640703354289;5546.77812887484;5722.1416787482;6117.204763380732;6126.234220722387;6127.080937859312;6127.417895299939;5194.065068287707;5358.866028349284;5414.945850541483;5419.268398766195;5420.159875219348;12133.090018248578;12241.571544995972;12254.387280636021;12264.325462099581;12295.385230738517;1791.3551121596345;1867.2437662746609;1926.5087402712359;2061.443410279231;2446.6696995905504;8973.865392019125;9056.456612603264;9387.342885997983;9529.332946693734;13038.544238273504;1664.2344521520115;1701.157926826229;1784.286285485816;1788.2668106076576;1794.4526919289613;64215.6789216051;64448;64857.67571162161;65871.67064164697;67255.3274467254;9757;9764.316497845224;9843;9915.752106197258;10014.148797352307;13426.731465370638;13522.594322170155;13524.797128043087;13528.864711352957;13538.25539595312;7454.850902982019;7521.548707077593;7551.244875512514;7604.695812167452;7641.197674244125;7211.350978411863;7233.638318084075;7281.1262648482525;7448.292412220831;7459.8508029839095;4333.090051089243;4346.956530434719;4349.151915376471;4354.804033818486;4425.468943726773;1615.9596010099842;1753.1059159828578;1777.3334999375234;1812.6193499365281;1856.758621379212;372.35582442374846;376.24938248195025;382.45309207833066;386.60180014585023;763.6143747407524;10527.368357898398;10727.302725322828;10784.568617255221;10950.890491095146;10962.287451315638;394.35129212445366;403.07494300580237;409.78281510799326;413.97930103494707;414.7552943763194;5657.80197693087;5708.71456427177;5777.075667893117;5807.12893066035;5865.237519122486;416574;420139;420840;428795;429788;70402.64798675974;73656;77801.61099194468;81425.59287203527;84157;877.5831480046927;879.8449421245473;902.2060586683676;910.6903652758094;936.447495977363;16162.595935101717;16199.838001619833;16451.341946322013;16489.257983391017;16648.83351166473;27959.440811183256;37733.81133094317;37751.81124094362;38050.2389952205;38933.610663893;32407.675923240466;44973.55026449694;53640;54404.72797635986;54654;7303.30618591233;7354.154272258545;7447.739329123455;7502.737404190827;7557.924420755942;9399.95300023523;11677.124215684027;11700.648980530597;11772.352520611448;11937.820932685843;10323.380597164194;10450.529726162189;10654.414007229676;10954.671359859218;10997.12023038171;9997.500124993867;10283.228757843042;10374.325668831501;10390.376577405379;10487.161027117965;10031.648892288735;10285.588576456857;10427.94786026065;10676.786464270826;11026;6579.835504112435;6862.862742745217;7102.218755936946;7106.6446677666945;7732.8453430932195;7659;9588.712338629852;10172.13536849376;10368.118709909742;10543.736406589896 23:55:28 INFO - PROCESS | 11385 | |3;mootools.html;1376.8141300924376;1418.1774570748967;1502.1738044075762;1675.1121905390148;1720.9913950430255;6699.866002679943;6926.168859736826;7497.962510187448;7958.721444749428;8006.719764808233;7348.559086454817;7616.7334143305;7623.923760762391;7800.765977020698;7879.645415956282;2173.1850556041486;2196.6595177747395;2198.087793565668;2199.9340019799433;2200.922967696131;1871.5882505848692;1939.806019398056;1941.8446524278024;1947.3379051122615;2151.064287035145;2136.6688163334707;2210.0165426385265;2210.071769856664;2216.8669879807185;2220.755716871143;2087.2277257414703;2095.559932414195;2104.757952835428;2110.725605671268;2195.3194509701884;2135.6689713094497;2142.121730090671;2142.2287976328507;2143.4534193780487;2144.774798646151;8027.518348899085;8082.555459449728;8084.959575202086;8087.757367278991;8103.392245581605;4520.751358675271;4667.576389201292;4676.275177347483;4686.531346865286;4690.718556886598;2855.300451389402;2860.356419805548;2957.600723902267;2976.3898400827993;2990.3421247325555;959.4818797849153;975.4586204656413;978.7602037500858;979.304693667497;989.9208063354914;10584.523696433678;10598.682039538826;10603.20475964298;10606.893931060746;10612.363258204532;4022.4770779798437;4167.10407262434;4291.077418355068;4306.784660767012;4309.332053531708;8903.599338029804;8984.056674049261;9018.278537716968;9029.729108126767;9040.8643870342;4558.361829343895;4564.406627138451;4580.702254353457;4582.518835522289;4597.517260687647;4124.319487284564;4158.230727315396;4193.643540299109;4210.073783767566;4213.094184750232;3359.3953088443827;3455.36075825973;3458.3774920514047;3682.4660424238336;3770.981145094312;1137.4653912661036;1156.6009726644295;1189.4766302826729;1236.462138969533;1241.9379031048593;857.8069934264865;865.5585651317747;868.1015149320423;886.1006078829993;890.5631122000225;5321.6540924839765;5350.063738845686;5383.946160538345;5576.386597474275;5729.799457018984;867.236831588211;870.9085546017703;882.1972005474987;882.3823323673454;902.0348227396622;3801.82891769871;3822.7132965027736;3826.521684789401;3925.646691797752;3959.544652365015;9461.858072128924;9590.760230994281;9779.902200978042;9787.412755234567;9788.363756355815;9639.807203855884;9701.6119355225;9714;9739.220862330996;9755.853662195073;7249.637518124073;7435.925640743631;7464.141623713343;7475.813104672318;7479.214682458372;5284.207368894697;5322.41453440129;5444.237806707143;5494.09347457665;5501.944980550144;9059.22996545301;9072.228860546664;9101.908980910372;9117.680881169128;9171.908280917372;8573.485590864568;8869.467831930106;8888.022317545194;9163.450192988443;9231.630734770803;6772.05191273232;6922.93077069243;6943.965280173769;6945.687444064928;6950.200726916267;7448.627568621656;7451.2176221495965;7498.887516687363;7515.060617422822;7517.736879209201;5986.132010858489;6048.667323297261;6726.764563240263;6835.555688880406;6913.239543650295;6717.429018533479;6725.293844146294;6784.86430271382;6796.422304104009;6810.421114205348;6477.417032466912;6490.707918143789;6530.216374035146;6545.312742162195;6546.378094081055;4657.184992626345;4715.952840471688;4758;4762.285657151317;4810.062037902575;4776.188048031912;4856.223004319292;4857.222844344888;4863.2461968394955;4946.0355230729665 23:55:28 INFO - PROCESS | 11385 | |4;prototype.html;295.5478118478727;299.5506739890165;305.8486049405543;306.5539639824056;306.8143773017325;4808.879778005552;4829.396325459317;4839.903201935959;4840.757962101899;4852.393450818648;4744.8410973007285;4776.331313616097;4794.832180873661;4797.208460603996;4797.592204662608;3551.8579256829694;3682.815859207042;3683.1528748387886;3684.5578530576367;3706.8887933362043;3668.779873207616;3705.907352316187;3777.7355585108917;3801.144742432958;3824.464574959508;3696.3161815064163;3739.8504059837574;3762.0030691866677;3764.494202319067;3765.4351847222997;3529.982350088259;3709.610490898444;3738.719596030309;3744.1388480649466;3748.231612519427;3226.7902586332048;3228.6287076986214;3237.352529494087;3238.4008958342783;3239.6922292382187;4652.511486293958;4654.976725116387;4657.2315567931255;4663.2305669564485;4669.299605059235;4088.2845502037026;4232.619064284229;4234.322508398642;4239.533651298355;4247.660187185018;4984.401871775374;4988.226824842155;5010.649254552182;5015.297858299841;5020.573251273646;3577.177249232665;3590;3595.676389124991;3596.8381422836037;3597.6222496638;5107.693538387709;5221.190715439113;5234.659747116425;5244.501772331622;5255.947440525584;3608.1701208722143;3614.3494171048937;3621.6016238213774;3626.7668992542663;3627.782333060025;3653;3667.798271095062;3668.321360548254;3669.9633003670156;3674.8713795017047;4202.814536441095;4206.170315912588;4212.347086201644;4218.156368726267;4221.936670949938;4908.852734417973;5003.924941125886;5004.3994720633755;5007.873228523553;5016.974915125401;1270.3140304235794;1280.3854150008049;1281.2760790153534;1282.8781265779735;1284.1460428814921;792.84935862186;807.3097501636134;820.9917900821035;821.954792486407;832.4963397144761;4380.649548036149;4440.578145076212;4444.755538445352;4450.688451808407;4468.597826195658;5170.45710200431;5174.172132458789;5174.767135478913;5176.534111929869;5199.66202196856;4369.536833082507;4425.225585522585;4445.355423463579;4451.755153466591;4460.531644177379;2624.2127361791386;2732.6883096113975;2732.9726702733115;2733.510236920883;2741.3831887825477;4841.273808928619;4843.927341089887;4850.587700045465;4872.658913875995;4902.852914412573;5019.648624596316;5264.578833693296;5278.9472105278455;5281.709505977208;5289.206619007103;4910.45984941649;4939.332760309465;4943.332650092263;4953.900921981613;4957.529034741694;5214.478552144907;5222.764975576184;5225.216217567396;5228.562145409891;5231.843044708665;4864.610831133572;5094.770735316845;5128.1794912813775;5129.256257842667;5147.768350424315;4868.3427737255015;4876.414830220397;4895.485973972682;4923.359963204761;4940.1466855852495;3669.156094098319;3697.4084146537502;3704.2961837250837;3713.405855063177;3727.8508859645312;5055.924161137512;5224.4139151120435;5229.267902493578;5241.31862857826;5252.9737351314525;5051.722155281348;5053.69677819332;5068.315777370008;5073.8731531712;5085.466026067357;5045.495450454925;5049.671771334852;5072.54347108762;5081.949180508148;5084.669496482717;4868.632494365677;4920.51513985435;5015.924761128513;5020.339220213293;5021.623378246719;4866.756662166807;4939.87585338308;5097.464766199496;5107.923381149211;5115.386153661584;4956.281339205867;4982.925256121233;4991.101601711727;4994.2508623706735;4996.525330093636 23:55:28 INFO - PROCESS | 11385 | |5;yui.html;607.5807692692042;629.3989240275536;644.2558844534565;658.5061204096927;710.9360157585817;11563.364014979174;12658.303793291365;13760.105593136452;13798.310084495784;14291.857081429183;13388.598342049754;13886.652833679163;13906.58280251594;13913.652158696037;13922.791158132635;622.7166639179162;750.4446709435019;773.4663082473076;774.4462709162948;774.7404619452462;629.1726379810557;637.2766909557662;637.4295005969655;738.3908275672565;759.1345865713091;816.1960468938091;816.5386556595535;818.4761752478419;818.6929901287017;818.7625588579305;802.0896282719098;806.238104990784;810.6554714246481;810.7365106340463;810.8459392715395;586.7389011889711;591.1516973143553;591.2018774654225;591.325888487125;591.8313280714975;12841;12889.871101288962;12900.870991290061;12912.418941147671;13021.414036368385;13273.800892986614;13311.866881331256;13350.198988060747;13505.459781608724;13705.588832335046;10251.179905607534;10317.638882639147;10325.89674103257;10411.583536658525;10483.423411712352;3129.4523458394688;3167.2398624329994;3169.3344397676515;3195.2650890295363;3266.6080070391704;59385.40614593842;59527.107093393635;60295.09557356687;60377.396226037614;60542;9896.069360131976;9946.055124763136;10061.64784232563;10247.333923294962;10259.384436933808;17589.912050439667;18570.628587428175;18594.349197778014;18626.534336641693;18664.906675466536;6719.160104986877;6931.202911665122;6955.947995341387;6956.130483689539;7166.892496612555;3746.438034294823;3895.3183192941688;3898.7270891037924;3932.4494570760116;4009.7393669411395;2858.371158345161;2980.5678176664264;2982.6719060903283;2984.1346009656954;2985.0746268656353;516.354556803995;528.899509093271;538.9919151212735;542.1542393865583;543.5108402437837;551.9797540999921;569.7920259105397;578.1991941161438;580.5297708855841;609.7439075588263;7636.31273185416;8089.433739638169;8296.751097466966;8342.582870856433;8465.703700370457;472.3906161052273;502.85668584453254;532.3611666000814;608.1698481572621;611.3947192279611;4375.934360984587;4483.820647174077;4576.954230457719;4598.992137880258;4626.167289887785;101040;103178.48410758049;105357.47321263344;106795;107492.4625376868;51811;67511;67769.66115169393;68656;82039;64649.67675161594;71933.2806671937;72485.6375718118;73180.26819731841;73862.63068684623;8526;8609;8790.129336647438;8825.911740882766;8901.55492225399;37663.62336376601;43573.78213109041;43781.56218437775;44276.77861610671;45014.77492612516;37819.81090094532;41693.58306417018;56219;62770.68614656897;63157.36842631515;11526.250793698382;11614.419279036183;11808.350540720343;11973.281603103842;12401.069919755873;13448.394822232827;13476.460941562227;13685.11046781956;13852.445902163801;13948.860511394756;12300.200486968319;12497.93751031239;12863.163894346837;12924.353782311035;13743.725125497635;11636.592719254786;11645.941770291094;11907.226030308002;12379.381030948596;12396.256224626552;10973.3964631946;11479.024282936043;11542.538298467967;12412.069094817743;12419;9723.951380243054;9857.605695772088;10035.598576056876;10129.043839004255;10144.74638134023;10168.796624067329;10297.845532317171;10340.638077667245;10380.32527885685;10431.217658675781 23:55:28 INFO - PROCESS | 11385 | __end_tp_report 23:55:28 INFO - PROCESS | 11385 | __start_cc_report 23:55:28 INFO - PROCESS | 11385 | _x_x_mozilla_cycle_collect,1166 23:55:28 INFO - PROCESS | 11385 | __end_cc_report 23:55:28 INFO - PROCESS | 11385 | __startTimestamp1468997728724__endTimestamp 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | ------- Summary: start ------- 23:55:28 INFO - PROCESS | 11385 | Number of tests: 6 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | [#0] dojo.html Cycles:165 Average:4636.58 Median:4773.14 stddev:487.49 (10.2%) stddev-sans-first:462.17 23:55:28 INFO - PROCESS | 11385 | Values: 2603.8 2611.6 2640.1 2669.0 2674.2 4568.9 4621.2 4684.1 4704.4 4719.3 4592.8 4593.8 4613.9 4635.4 4641.6 4015.3 4186.2 4278.1 4315.1 4328.5 4207.4 4299.5 4304.5 4305.5 4337.3 4228.8 4276.3 4281.9 4286.6 4332.4 4268.6 4280.8 4327.4 4341.5 4353.3 4332.7 4336.2 4337.0 4358.0 4360.6 4569.4 4609.1 4686.7 4689.4 4712.0 4993.7 5012.4 5019.7 5038.2 5053.4 4972.0 5066.3 5104.2 5113.4 5114.0 4721.2 4771.0 4773.1 4802.6 4819.0 5240.0 5267.6 5270.7 5280.1 5282.4 4745.7 4780.1 5007.7 5055.9 5063.0 4890.4 4911.6 4929.0 4957.8 4983.4 4927.2 4928.3 4931.5 4933.8 4983.8 4848.9 4880.4 4915.3 4916.4 4924.0 4294.0 4300.8 4309.0 4351.5 4355.5 3728.7 3732.7 3751.1 3771.8 3785.0 4239.0 4266.7 4293.4 4323.1 4324.2 4963.9 4998.5 4999.6 5003.3 5039.6 4299.3 4301.8 4303.2 4318.9 4345.7 4473.5 4494.6 4528.3 4535.9 4541.9 4695.0 4719.8 4726.3 4767.3 4778.4 5013.9 5017.8 5023.4 5027.0 5066.7 4580.7 4677.3 4704.9 4727.3 4750.7 4961.1 4972.4 4982.0 4984.3 5035.7 5021.0 5035.8 5040.2 5042.2 5092.6 4797.8 4823.3 4844.3 4854.1 4919.4 4916.7 4953.4 4955.7 4961.8 5009.3 4877.3 4885.9 4886.9 4888.2 4933.3 4798.9 4834.3 4898.0 4935.6 4940.4 4846.5 4857.2 4860.2 4883.3 4905.4 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | [#1] ext.html Cycles:180 Average:44536.94 Median:34310.57 stddev:80983.04 (236.0%) stddev-sans-first:81142.94 23:55:28 INFO - PROCESS | 11385 | Values: 570.4 584.4 593.1 603.2 605.8 27393.6 38945.6 40078.0 40443.8 44638.3 41428.0 41736.4 41835.4 41863.0 41909.4 7507.5 7779.8 7892.4 7926.6 7931.0 7636.5 7759.8 7765.9 9965.3 10250.3 10266.4 10346.2 10352.5 10353.7 10363.5 10173.8 10216.6 10245.1 10249.3 10258.2 7604.0 9953.8 10326.5 10327.4 10626.6 39083.4 39314.2 39532.0 39532.8 39536.0 3056.4 3067.3 3289.4 3685.7 3711.9 28891.4 28990.9 29013.6 29470.3 29570.3 3457.6 3477.8 3505.1 3528.8 3571.8 184038.0 184392.0 184889.0 184897.0 185339.0 31512.7 52913.7 53195.7 53284.0 53329.0 31833.0 34185.3 34274.7 34285.1 34336.0 14162.0 14284.3 14377.6 14383.9 14389.6 10679.8 11909.6 12037.6 12050.8 12057.3 7761.1 7984.1 7993.2 8057.7 8122.1 3086.2 3130.3 3136.9 3141.0 3180.5 835.1 973.1 998.9 1007.5 1023.8 28159.9 28293.9 28310.4 28393.7 28487.9 944.7 953.2 966.6 980.8 1063.0 14843.2 14983.3 15096.7 15219.9 15250.5 391663.0 393633.0 396583.0 397026.0 398495.0 50046.0 50458.0 50566.7 50676.5 50682.0 1077.7 1157.0 1173.9 1202.5 1212.1 27878.9 29296.6 29298.9 29386.9 29600.7 41558.0 42010.8 42020.5 42033.0 42120.6 298097.0 303102.0 303435.0 303475.0 304497.0 22159.4 22545.5 22612.8 23634.9 23890.4 34422.5 34856.1 41366.2 42118.6 47183.0 34870.5 35956.5 36665.5 37369.4 37446.8 36366.0 36366.0 36742.8 37174.3 37351.6 35423.5 35490.0 35703.3 36098.3 36242.0 31940.0 32124.5 32499.5 32583.7 33014.5 25091.2 25186.0 25518.0 25568.5 25594.5 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | [#2] jquery.html Cycles:180 Average:24507.48 Median:418356.50 stddev:69711.60 (16.7%) stddev-sans-first:69883.60 23:55:28 INFO - PROCESS | 11385 | Values: 368.8 369.6 371.0 386.0 387.5 16361.9 17303.1 18153.8 18162.8 18178.9 11474.7 16001.3 16705.9 16787.8 17579.9 4626.8 4768.7 4822.0 4827.9 4828.5 3487.4 3676.5 5213.8 5477.3 5493.0 5510.1 5519.3 5521.3 5527.6 5546.8 5722.1 6117.2 6126.2 6127.1 6127.4 5194.1 5358.9 5414.9 5419.3 5420.2 12133.1 12241.6 12254.4 12264.3 12295.4 1791.4 1867.2 1926.5 2061.4 2446.7 8973.9 9056.5 9387.3 9529.3 13038.5 1664.2 1701.2 1784.3 1788.3 1794.5 64215.7 64448.0 64857.7 65871.7 67255.3 9757.0 9764.3 9843.0 9915.8 10014.1 13426.7 13522.6 13524.8 13528.9 13538.3 7454.9 7521.5 7551.2 7604.7 7641.2 7211.4 7233.6 7281.1 7448.3 7459.9 4333.1 4347.0 4349.2 4354.8 4425.5 1616.0 1753.1 1777.3 1812.6 1856.8 372.4 376.2 382.5 386.6 763.6 10527.4 10727.3 10784.6 10950.9 10962.3 394.4 403.1 409.8 414.0 414.8 5657.8 5708.7 5777.1 5807.1 5865.2 416574.0 420139.0 420840.0 428795.0 429788.0 70402.6 73656.0 77801.6 81425.6 84157.0 877.6 879.8 902.2 910.7 936.4 16162.6 16199.8 16451.3 16489.3 16648.8 27959.4 37733.8 37751.8 38050.2 38933.6 32407.7 44973.6 53640.0 54404.7 54654.0 7303.3 7354.2 7447.7 7502.7 7557.9 9400.0 11677.1 11700.6 11772.4 11937.8 10323.4 10450.5 10654.4 10954.7 10997.1 9997.5 10283.2 10374.3 10390.4 10487.2 10031.6 10285.6 10427.9 10676.8 11026.0 6579.8 6862.9 7102.2 7106.6 7732.8 7659.0 9588.7 10172.1 10368.1 10543.7 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | [#3] mootools.html Cycles:180 Average:5175.58 Median:5469.17 stddev:2879.99 (52.7%) stddev-sans-first:2873.92 23:55:28 INFO - PROCESS | 11385 | Values: 1376.8 1418.2 1502.2 1675.1 1721.0 6699.9 6926.2 7498.0 7958.7 8006.7 7348.6 7616.7 7623.9 7800.8 7879.6 2173.2 2196.7 2198.1 2199.9 2200.9 1871.6 1939.8 1941.8 1947.3 2151.1 2136.7 2210.0 2210.1 2216.9 2220.8 2087.2 2095.6 2104.8 2110.7 2195.3 2135.7 2142.1 2142.2 2143.5 2144.8 8027.5 8082.6 8085.0 8087.8 8103.4 4520.8 4667.6 4676.3 4686.5 4690.7 2855.3 2860.4 2957.6 2976.4 2990.3 959.5 975.5 978.8 979.3 989.9 10584.5 10598.7 10603.2 10606.9 10612.4 4022.5 4167.1 4291.1 4306.8 4309.3 8903.6 8984.1 9018.3 9029.7 9040.9 4558.4 4564.4 4580.7 4582.5 4597.5 4124.3 4158.2 4193.6 4210.1 4213.1 3359.4 3455.4 3458.4 3682.5 3771.0 1137.5 1156.6 1189.5 1236.5 1241.9 857.8 865.6 868.1 886.1 890.6 5321.7 5350.1 5383.9 5576.4 5729.8 867.2 870.9 882.2 882.4 902.0 3801.8 3822.7 3826.5 3925.6 3959.5 9461.9 9590.8 9779.9 9787.4 9788.4 9639.8 9701.6 9714.0 9739.2 9755.9 7249.6 7435.9 7464.1 7475.8 7479.2 5284.2 5322.4 5444.2 5494.1 5501.9 9059.2 9072.2 9101.9 9117.7 9171.9 8573.5 8869.5 8888.0 9163.5 9231.6 6772.1 6922.9 6944.0 6945.7 6950.2 7448.6 7451.2 7498.9 7515.1 7517.7 5986.1 6048.7 6726.8 6835.6 6913.2 6717.4 6725.3 6784.9 6796.4 6810.4 6477.4 6490.7 6530.2 6545.3 6546.4 4657.2 4716.0 4758.0 4762.3 4810.1 4776.2 4856.2 4857.2 4863.2 4946.0 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | [#4] prototype.html Cycles:180 Average:4174.24 Median:4819.14 stddev:1223.66 (25.4%) stddev-sans-first:1191.95 23:55:28 INFO - PROCESS | 11385 | Values: 295.5 299.6 305.8 306.6 306.8 4808.9 4829.4 4839.9 4840.8 4852.4 4744.8 4776.3 4794.8 4797.2 4797.6 3551.9 3682.8 3683.2 3684.6 3706.9 3668.8 3705.9 3777.7 3801.1 3824.5 3696.3 3739.9 3762.0 3764.5 3765.4 3530.0 3709.6 3738.7 3744.1 3748.2 3226.8 3228.6 3237.4 3238.4 3239.7 4652.5 4655.0 4657.2 4663.2 4669.3 4088.3 4232.6 4234.3 4239.5 4247.7 4984.4 4988.2 5010.6 5015.3 5020.6 3577.2 3590.0 3595.7 3596.8 3597.6 5107.7 5221.2 5234.7 5244.5 5255.9 3608.2 3614.3 3621.6 3626.8 3627.8 3653.0 3667.8 3668.3 3670.0 3674.9 4202.8 4206.2 4212.3 4218.2 4221.9 4908.9 5003.9 5004.4 5007.9 5017.0 1270.3 1280.4 1281.3 1282.9 1284.1 792.8 807.3 821.0 822.0 832.5 4380.6 4440.6 4444.8 4450.7 4468.6 5170.5 5174.2 5174.8 5176.5 5199.7 4369.5 4425.2 4445.4 4451.8 4460.5 2624.2 2732.7 2733.0 2733.5 2741.4 4841.3 4843.9 4850.6 4872.7 4902.9 5019.6 5264.6 5278.9 5281.7 5289.2 4910.5 4939.3 4943.3 4953.9 4957.5 5214.5 5222.8 5225.2 5228.6 5231.8 4864.6 5094.8 5128.2 5129.3 5147.8 4868.3 4876.4 4895.5 4923.4 4940.1 3669.2 3697.4 3704.3 3713.4 3727.9 5055.9 5224.4 5229.3 5241.3 5253.0 5051.7 5053.7 5068.3 5073.9 5085.5 5045.5 5049.7 5072.5 5081.9 5084.7 4868.6 4920.5 5015.9 5020.3 5021.6 4866.8 4939.9 5097.5 5107.9 5115.4 4956.3 4982.9 4991.1 4994.3 4996.5 23:55:28 INFO - PROCESS | 11385 | 23:55:28 INFO - PROCESS | 11385 | [#5] yui.html Cycles:180 Average:17161.48 Median:24078.75 stddev:24169.52 (100.4%) stddev-sans-first:24205.36 23:55:28 INFO - PROCESS | 11385 | Values: 607.6 629.4 644.3 658.5 710.9 11563.4 12658.3 13760.1 13798.3 14291.9 13388.6 13886.7 13906.6 13913.7 13922.8 622.7 750.4 773.5 774.4 774.7 629.2 637.3 637.4 738.4 759.1 816.2 816.5 818.5 818.7 818.8 802.1 806.2 810.7 810.7 810.8 586.7 591.2 591.2 591.3 591.8 12841.0 12889.9 12900.9 12912.4 13021.4 13273.8 13311.9 13350.2 13505.5 13705.6 10251.2 10317.6 10325.9 10411.6 10483.4 3129.5 3167.2 3169.3 3195.3 3266.6 59385.4 59527.1 60295.1 60377.4 60542.0 9896.1 9946.1 10061.6 10247.3 10259.4 17589.9 18570.6 18594.3 18626.5 18664.9 6719.2 6931.2 6955.9 6956.1 7166.9 3746.4 3895.3 3898.7 3932.4 4009.7 2858.4 2980.6 2982.7 2984.1 2985.1 516.4 528.9 539.0 542.2 543.5 552.0 569.8 578.2 580.5 609.7 7636.3 8089.4 8296.8 8342.6 8465.7 472.4 502.9 532.4 608.2 611.4 4375.9 4483.8 4577.0 4599.0 4626.2 101040.0 103178.5 105357.5 106795.0 107492.5 51811.0 67511.0 67769.7 68656.0 82039.0 64649.7 71933.3 72485.6 73180.3 73862.6 8526.0 8609.0 8790.1 8825.9 8901.6 37663.6 43573.8 43781.6 44276.8 45014.8 37819.8 41693.6 56219.0 62770.7 63157.4 11526.3 11614.4 11808.4 11973.3 12401.1 13448.4 13476.5 13685.1 13852.4 13948.9 12300.2 12497.9 12863.2 12924.4 13743.7 11636.6 11645.9 11907.2 12379.4 12396.3 10973.4 11479.0 11542.5 12412.1 12419.0 9724.0 9857.6 10035.6 10129.0 10144.7 10168.8 10297.8 10340.6 10380.3 10431.2 23:55:28 INFO - PROCESS | 11385 | -------- Summary: end -------- 23:55:28 INFO - PROCESS | 11385 | 23:55:29 INFO - TEST-INFO | 11385: exit 0 23:55:29 INFO - TEST-OK | dromaeo_css | took 1119668ms 23:55:29 INFO - TEST-START | kraken 23:55:29 INFO - operating with platform_type : linux_ 23:55:29 INFO - Initialising browser for kraken test... 23:55:29 INFO - TEST-INFO | started process 11575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5_lYZ/profile http://localhost:41680/getInfo.html) 23:55:33 INFO - PROCESS | 11575 | __metrics Screen width/height:1600/1200 23:55:33 INFO - PROCESS | 11575 | colorDepth:24 23:55:33 INFO - PROCESS | 11575 | Browser inner width/height: 1024/697 23:55:33 INFO - PROCESS | 11575 | __metrics 23:55:34 INFO - PROCESS | 11575 | 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:55:34 INFO - PROCESS | 11575 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:55:34 INFO - PROCESS | 11575 | console.error: PushService: 23:55:34 INFO - PROCESS | 11575 | stateChangeProcessEnqueue: Error transitioning state 23:55:34 INFO - PROCESS | 11575 | UnknownError 23:55:35 INFO - TEST-INFO | 11575: exit 0 23:55:35 INFO - Browser initialized. 23:55:35 INFO - Running cycle 1/1 for kraken test... 23:55:35 INFO - TEST-INFO | started process 11656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5_lYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:55:47 INFO - PROCESS | 11656 | RSS: Main: 158613504 23:55:47 INFO - PROCESS | 11656 | 23:55:50 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41680/tests/kraken/driver.html?testName=audio-beat-detection) 23:55:51 INFO - PROCESS | 11656 | RSS: Main: 217960448 23:55:51 INFO - PROCESS | 11656 | 23:55:53 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41680/tests/kraken/driver.html?testName=audio-dft) 23:55:54 INFO - PROCESS | 11656 | RSS: Main: 205692928 23:55:54 INFO - PROCESS | 11656 | 23:55:57 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41680/tests/kraken/driver.html?testName=audio-fft) 23:55:58 INFO - PROCESS | 11656 | RSS: Main: 272011264 23:55:58 INFO - PROCESS | 11656 | 23:56:00 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41680/tests/kraken/driver.html?testName=audio-oscillator) 23:56:01 INFO - PROCESS | 11656 | RSS: Main: 181579776 23:56:01 INFO - PROCESS | 11656 | 23:56:03 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41680/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:56:03 INFO - PROCESS | 11656 | RSS: Main: 185950208 23:56:03 INFO - PROCESS | 11656 | 23:56:07 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41680/tests/kraken/driver.html?testName=imaging-darkroom) 23:56:07 INFO - PROCESS | 11656 | RSS: Main: 222273536 23:56:07 INFO - PROCESS | 11656 | 23:56:11 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41680/tests/kraken/driver.html?testName=imaging-desaturate) 23:56:11 INFO - PROCESS | 11656 | RSS: Main: 222945280 23:56:11 INFO - PROCESS | 11656 | 23:56:14 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41680/tests/kraken/driver.html?testName=json-parse-financial) 23:56:15 INFO - PROCESS | 11656 | RSS: Main: 222371840 23:56:15 INFO - PROCESS | 11656 | 23:56:16 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41680/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:56:17 INFO - PROCESS | 11656 | RSS: Main: 210972672 23:56:17 INFO - PROCESS | 11656 | 23:56:19 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:56:20 INFO - PROCESS | 11656 | RSS: Main: 216223744 23:56:20 INFO - PROCESS | 11656 | 23:56:22 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:56:22 INFO - PROCESS | 11656 | RSS: Main: 212566016 23:56:22 INFO - PROCESS | 11656 | 23:56:25 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:56:26 INFO - PROCESS | 11656 | RSS: Main: 223129600 23:56:26 INFO - PROCESS | 11656 | 23:56:29 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:56:29 INFO - PROCESS | 11656 | RSS: Main: 223563776 23:56:29 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | Cycle 1(1): loaded http://localhost:41680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41680/tests/kraken/driver.html?testName=ai-astar) 23:56:31 INFO - PROCESS | 11656 | RSS: Main: 266584064 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | __start_tp_report 23:56:31 INFO - PROCESS | 11656 | _x_x_mozilla_page_load 23:56:31 INFO - PROCESS | 11656 | _x_x_mozilla_page_load_details 23:56:31 INFO - PROCESS | 11656 | |i|pagename|runs| 23:56:31 INFO - PROCESS | 11656 | |0;ai-astar;105;116;114;117;115;113;113;114;113;115 23:56:31 INFO - PROCESS | 11656 | |1;audio-beat-detection;163;127;126;173;123;124;152;123;185;121 23:56:31 INFO - PROCESS | 11656 | |2;audio-dft;161;160;162;164;162;160;161;162;162;159 23:56:31 INFO - PROCESS | 11656 | |3;audio-fft;75;75;77;104;74;77;75;76;100;74 23:56:31 INFO - PROCESS | 11656 | |4;audio-oscillator;86;86;120;85;85;85;118;85;85;125 23:56:31 INFO - PROCESS | 11656 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;116;116 23:56:31 INFO - PROCESS | 11656 | |6;imaging-darkroom;146;147;146;146;146;145;147;146;146;146 23:56:31 INFO - PROCESS | 11656 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 23:56:31 INFO - PROCESS | 11656 | |8;json-parse-financial;64;62;64;63;65;63;63;63;63;64 23:56:31 INFO - PROCESS | 11656 | |9;json-stringify-tinderbox;66;67;65;65;66;66;66;66;66;66 23:56:31 INFO - PROCESS | 11656 | |10;stanford-crypto-aes;79;78;84;78;77;80;78;79;77;86 23:56:31 INFO - PROCESS | 11656 | |11;stanford-crypto-ccm;135;131;128;129;130;137;128;128;170;131 23:56:31 INFO - PROCESS | 11656 | |12;stanford-crypto-pbkdf2;165;166;166;166;165;163;164;165;165;168 23:56:31 INFO - PROCESS | 11656 | |13;stanford-crypto-sha256-iterative;67;66;67;66;67;69;71;66;64;66 23:56:31 INFO - PROCESS | 11656 | __end_tp_report 23:56:31 INFO - PROCESS | 11656 | __start_cc_report 23:56:31 INFO - PROCESS | 11656 | _x_x_mozilla_cycle_collect,1944 23:56:31 INFO - PROCESS | 11656 | __end_cc_report 23:56:31 INFO - PROCESS | 11656 | __startTimestamp1468997791644__endTimestamp 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | ------- Summary: start ------- 23:56:31 INFO - PROCESS | 11656 | Number of tests: 14 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:3.27 (2.9%) stddev-sans-first:1.42 23:56:31 INFO - PROCESS | 11656 | Values: 105.0 116.0 114.0 117.0 115.0 113.0 113.0 114.0 113.0 115.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:139.50 stddev:24.31 (17.4%) stddev-sans-first:24.53 23:56:31 INFO - PROCESS | 11656 | Values: 163.0 127.0 126.0 173.0 123.0 124.0 152.0 123.0 185.0 121.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.50 23:56:31 INFO - PROCESS | 11656 | Values: 161.0 160.0 162.0 164.0 162.0 160.0 161.0 162.0 162.0 159.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.31 (15.1%) stddev-sans-first:11.81 23:56:31 INFO - PROCESS | 11656 | Values: 75.0 75.0 77.0 104.0 74.0 77.0 75.0 76.0 100.0 74.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:17.34 (20.4%) stddev-sans-first:18.01 23:56:31 INFO - PROCESS | 11656 | Values: 86.0 86.0 120.0 85.0 85.0 85.0 118.0 85.0 85.0 125.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:56:31 INFO - PROCESS | 11656 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 23:56:31 INFO - PROCESS | 11656 | Values: 146.0 147.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:56:31 INFO - PROCESS | 11656 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 23:56:31 INFO - PROCESS | 11656 | Values: 64.0 62.0 64.0 63.0 65.0 63.0 63.0 63.0 63.0 64.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 23:56:31 INFO - PROCESS | 11656 | Values: 66.0 67.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:3.03 (3.8%) stddev-sans-first:3.20 23:56:31 INFO - PROCESS | 11656 | Values: 79.0 78.0 84.0 78.0 77.0 80.0 78.0 79.0 77.0 86.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:131.00 stddev:12.77 (9.7%) stddev-sans-first:13.55 23:56:31 INFO - PROCESS | 11656 | Values: 135.0 131.0 128.0 129.0 130.0 137.0 128.0 128.0 170.0 131.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.50 stddev:1.34 (0.8%) stddev-sans-first:1.41 23:56:31 INFO - PROCESS | 11656 | Values: 165.0 166.0 166.0 166.0 165.0 163.0 164.0 165.0 165.0 168.0 23:56:31 INFO - PROCESS | 11656 | 23:56:31 INFO - PROCESS | 11656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.91 (2.9%) stddev-sans-first:2.03 23:56:31 INFO - PROCESS | 11656 | Values: 67.0 66.0 67.0 66.0 67.0 69.0 71.0 66.0 64.0 66.0 23:56:31 INFO - PROCESS | 11656 | -------- Summary: end -------- 23:56:31 INFO - PROCESS | 11656 | 23:56:32 INFO - TEST-INFO | 11656: exit 0 23:56:32 INFO - TEST-OK | kraken | took 63204ms 23:56:32 INFO - SUITE-END | took 1182s 23:56:32 INFO - Completed test suite (00:19:42) 23:56:32 INFO - javascript benchmark 23:56:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.7526434988677, 2611.608258761187, 2640.102365195833, 2668.973310266898, 2674.1576403432928, 4568.931466028012, 4621.214393553096, 4684.086603112394, 4704.411948506437, 4719.339292499053, 4592.816287348511, 4593.770311484421, 4613.9077218455695, 4635.374224479694, 4641.559051890065, 4015.297322968469, 4186.162767446508, 4278.058827058042, 4315.050688848449, 4328.502222244435, 4207.410962465257, 4299.462567179103, 4304.548022457629, 4305.4833419989645, 4337.349397590355, 4228.788560571959, 4276.251655960225, 4281.892952676177, 4286.592773686526, 4332.415123958257, 4268.59448352406, 4280.807363668642, 4327.3725309830215, 4341.500727416356, 4353.281708518122, 4332.653387728974, 4336.1978034063795, 4337.0, 4358.0, 4360.6293465055505, 4569.428821397325, 4609.055143695535, 4686.742229177394, 4689.413823272091, 4712.034033023222, 4993.650444468889, 5012.373453318335, 5019.698818070928, 5038.244263360489, 5053.444121146671, 4971.950280497185, 5066.341375621146, 5104.157813960692, 5113.437521872591, 5114.0, 4721.220998535237, 4771.045790841846, 4773.140834649727, 4802.567768900746, 4819.0, 5240.030594340059, 5267.578593712494, 5270.657407268515, 5280.128778751463, 5282.366116066097, 4745.667803253739, 4780.067886762048, 5007.7245751484015, 5055.9494405055475, 5063.0, 4890.413150421972, 4911.607071434277, 4929.0388374267395, 4957.752112394366, 4983.377077865267, 4927.162382395001, 4928.260760885896, 4931.457539670633, 4933.802647894044, 4983.825566105242, 4848.878778030577, 4880.389951256093, 4915.336429582032, 4916.385451818523, 4923.975380123076, 4293.957060429419, 4300.78496075195, 4309.0, 4351.477822661301, 4355.477342718894, 3728.7389882708494, 3732.701383889282, 3751.0809851586537, 3771.773693578394, 3784.9810750946067, 4238.978805106017, 4266.722663026893, 4293.3989241506215, 4323.113761678848, 4324.17840610283, 4963.90072198554, 4998.525140111684, 4999.625028122905, 5003.3495645565845, 5039.622028347815, 4299.290617048215, 4301.784910754513, 4303.182395344875, 4318.935215971763, 4345.717528360647, 4473.530279320689, 4494.617957473652, 4528.252838281713, 4535.886602834889, 4541.863744087683, 4695.0375173090115, 4719.8112075517965, 4726.291056341576, 4767.33257343979, 4778.37881075458, 5013.899722005613, 5017.8243761468175, 5023.372078490189, 5027.0, 5066.746662666926, 4580.725156490621, 4677.345171676036, 4704.929426058543, 4727.3381726559, 4750.691205071659, 4961.107000739901, 4972.378452693413, 4982.0, 4984.252362145708, 5035.748212589283, 5021.0, 5035.84892453227, 5040.218766091261, 5042.243663450512, 5092.643514954066, 4797.784099715452, 4823.324734537237, 4844.346013288161, 4854.053459575349, 4919.3604831371695, 4916.729579873141, 4953.430355509018, 4955.6531042826655, 4961.8015279389865, 5009.348784657971, 4877.268409738425, 4885.87785305356, 4886.902261954812, 4888.1690112681645, 4933.309336692938, 4798.928016079692, 4834.3231947528075, 4897.95102048975, 4935.580475659609, 4940.407151141886, 4846.466888642176, 4857.198562237191, 4860.246661767432, 4883.340748998839, 4905.386826646669], "value": 4605.646348962884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3839852958804, 584.4126652714021, 593.1310629927159, 603.1917230910578, 605.8000859716294, 27393.58909616355, 38945.61054389455, 40078.0, 40443.797781011126, 44638.33042504357, 41428.0, 41736.37395439071, 41835.372469412985, 41863.0, 41909.371359429635, 7507.549547027169, 7779.766607001785, 7892.447528672995, 7926.643301051467, 7931.0, 7636.541807491568, 7759.7672069838, 7765.922340776577, 9965.302428829984, 10250.282480226388, 10266.38401695897, 10346.22403319754, 10352.5341359639, 10353.689389318333, 10363.533640986136, 10173.796524069514, 10216.591336346537, 10245.129164021067, 10249.33379330341, 10258.17934565233, 7604.0, 9953.75115622108, 10326.535305911251, 10327.431991240479, 10626.628068017659, 39083.41374879379, 39314.21371572553, 39532.0, 39532.802335988425, 39536.0, 3056.404001219763, 3067.2638566744045, 3289.4407950648206, 3685.68671662909, 3711.888643340704, 28891.422171556453, 28990.855045724846, 29013.56479652807, 29470.26324341887, 29570.260743481584, 3457.567804024497, 3477.8087205203706, 3505.106197919514, 3528.788272703646, 3571.8392672329805, 184037.99999999866, 184392.0, 184889.0, 184897.0, 185339.0, 31512.684873151433, 52913.735431323366, 53195.73402132965, 53284.0, 53329.0, 31833.0, 34185.31629367399, 34274.65725342715, 34285.14287142841, 34336.0, 14162.0, 14284.285785710674, 14377.56867293983, 14383.856161438462, 14389.568312950629, 10679.78640427187, 11909.642710718692, 12037.638870833889, 12050.758984820255, 12057.336846473352, 7761.068671759312, 7984.121746607869, 7993.240642138988, 8057.677692892219, 8122.106568277485, 3086.1667349815425, 3130.3269796993754, 3136.8902088427253, 3140.98429507851, 3180.538821870862, 835.1439774231461, 973.0755782007121, 998.9051040151319, 1007.471077684207, 1023.7952409518126, 28159.859200703864, 28293.858530707214, 28310.43379132447, 28393.71606283952, 28487.857560712062, 944.6882528765491, 953.2374100719396, 966.5988614724951, 980.7695191629962, 1063.0326402973258, 14843.183624900734, 14983.250837458301, 15096.698066038618, 15219.923900380649, 15250.468805181034, 391663.0, 393633.0, 396583.0, 397026.0, 398495.0, 50046.0, 50458.0, 50566.74716626394, 50676.493235067916, 50682.0, 1077.7359546911057, 1156.988430115688, 1173.884809431044, 1202.506972141418, 1212.1333246728632, 27878.860605696842, 29296.560551591316, 29298.853505732335, 29386.853065734533, 29600.703992959796, 41558.0, 42010.78994605008, 42020.529281475, 42033.0, 42120.578794211666, 298097.0, 303102.0, 303435.0, 303475.0, 304497.0, 22159.446013849138, 22545.549089018456, 22612.773872261067, 23634.88182559076, 23890.40273993164, 34422.48366274558, 34856.12859678528, 41366.1726765469, 42118.57881421269, 47183.0, 34870.47694284537, 35956.4606530897, 36665.45001825028, 37369.4394584076, 37446.812765935996, 36366.0, 36366.0, 36742.81628591947, 37174.25651487009, 37351.62648373481, 35423.46864797082, 35490.0, 35703.28593428169, 36098.27803443864, 36242.0, 31940.0, 32124.518132228503, 32499.512507312884, 32583.674163258063, 33014.5047824278, 25091.24726258215, 25186.0, 25518.0, 25568.48863022692, 25594.48811023732], "value": 16858.6039168637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.77504722119505, 369.59344720807115, 370.98516059357627, 385.97298189126775, 387.5330227076373, 16361.918190409046, 17303.134843257834, 18153.81846181538, 18162.818371816276, 18178.909105454455, 11474.655760327183, 16001.27994240259, 16705.916470417662, 16787.83212167878, 17579.85730927492, 4626.791794369253, 4768.7138771673635, 4822.0, 4827.879303017417, 4828.46886842447, 3487.354839354715, 3676.466912297715, 5213.791448342062, 5477.287952566161, 5493.038718224295, 5510.1459273812625, 5519.31008623922, 5521.337439507265, 5527.640703354289, 5546.77812887484, 5722.1416787482, 6117.204763380732, 6126.234220722387, 6127.080937859312, 6127.417895299939, 5194.065068287707, 5358.866028349284, 5414.945850541483, 5419.268398766195, 5420.159875219348, 12133.090018248578, 12241.571544995972, 12254.387280636021, 12264.325462099581, 12295.385230738517, 1791.3551121596345, 1867.2437662746609, 1926.5087402712359, 2061.443410279231, 2446.6696995905504, 8973.865392019125, 9056.456612603264, 9387.342885997983, 9529.332946693734, 13038.544238273504, 1664.2344521520115, 1701.157926826229, 1784.286285485816, 1788.2668106076576, 1794.4526919289613, 64215.6789216051, 64448.0, 64857.67571162161, 65871.67064164697, 67255.3274467254, 9757.0, 9764.316497845224, 9843.0, 9915.752106197258, 10014.148797352307, 13426.731465370638, 13522.594322170155, 13524.797128043087, 13528.864711352957, 13538.25539595312, 7454.850902982019, 7521.548707077593, 7551.244875512514, 7604.695812167452, 7641.197674244125, 7211.350978411863, 7233.638318084075, 7281.1262648482525, 7448.292412220831, 7459.8508029839095, 4333.090051089243, 4346.956530434719, 4349.151915376471, 4354.804033818486, 4425.468943726773, 1615.9596010099842, 1753.1059159828578, 1777.3334999375234, 1812.6193499365281, 1856.758621379212, 372.35582442374846, 376.24938248195025, 382.45309207833066, 386.60180014585023, 763.6143747407524, 10527.368357898398, 10727.302725322828, 10784.568617255221, 10950.890491095146, 10962.287451315638, 394.35129212445366, 403.07494300580237, 409.78281510799326, 413.97930103494707, 414.7552943763194, 5657.80197693087, 5708.71456427177, 5777.075667893117, 5807.12893066035, 5865.237519122486, 416574.0, 420139.0, 420840.0, 428795.0, 429788.0, 70402.64798675974, 73656.0, 77801.61099194468, 81425.59287203527, 84157.0, 877.5831480046927, 879.8449421245473, 902.2060586683676, 910.6903652758094, 936.447495977363, 16162.595935101717, 16199.838001619833, 16451.341946322013, 16489.257983391017, 16648.83351166473, 27959.440811183256, 37733.81133094317, 37751.81124094362, 38050.2389952205, 38933.610663893, 32407.675923240466, 44973.55026449694, 53640.0, 54404.72797635986, 54654.0, 7303.30618591233, 7354.154272258545, 7447.739329123455, 7502.737404190827, 7557.924420755942, 9399.95300023523, 11677.124215684027, 11700.648980530597, 11772.352520611448, 11937.820932685843, 10323.380597164194, 10450.529726162189, 10654.414007229676, 10954.671359859218, 10997.12023038171, 9997.500124993867, 10283.228757843042, 10374.325668831501, 10390.376577405379, 10487.161027117965, 10031.648892288735, 10285.588576456857, 10427.94786026065, 10676.786464270826, 11026.0, 6579.835504112435, 6862.862742745217, 7102.218755936946, 7106.6446677666945, 7732.8453430932195, 7659.0, 9588.712338629852, 10172.13536849376, 10368.118709909742, 10543.736406589896], "value": 7563.896759135752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.8141300924376, 1418.1774570748967, 1502.1738044075762, 1675.1121905390148, 1720.9913950430255, 6699.866002679943, 6926.168859736826, 7497.962510187448, 7958.721444749428, 8006.719764808233, 7348.559086454817, 7616.7334143305, 7623.923760762391, 7800.765977020698, 7879.645415956282, 2173.1850556041486, 2196.6595177747395, 2198.087793565668, 2199.9340019799433, 2200.922967696131, 1871.5882505848692, 1939.806019398056, 1941.8446524278024, 1947.3379051122615, 2151.064287035145, 2136.6688163334707, 2210.0165426385265, 2210.071769856664, 2216.8669879807185, 2220.755716871143, 2087.2277257414703, 2095.559932414195, 2104.757952835428, 2110.725605671268, 2195.3194509701884, 2135.6689713094497, 2142.121730090671, 2142.2287976328507, 2143.4534193780487, 2144.774798646151, 8027.518348899085, 8082.555459449728, 8084.959575202086, 8087.757367278991, 8103.392245581605, 4520.751358675271, 4667.576389201292, 4676.275177347483, 4686.531346865286, 4690.718556886598, 2855.300451389402, 2860.356419805548, 2957.600723902267, 2976.3898400827993, 2990.3421247325555, 959.4818797849153, 975.4586204656413, 978.7602037500858, 979.304693667497, 989.9208063354914, 10584.523696433678, 10598.682039538826, 10603.20475964298, 10606.893931060746, 10612.363258204532, 4022.4770779798437, 4167.10407262434, 4291.077418355068, 4306.784660767012, 4309.332053531708, 8903.599338029804, 8984.056674049261, 9018.278537716968, 9029.729108126767, 9040.8643870342, 4558.361829343895, 4564.406627138451, 4580.702254353457, 4582.518835522289, 4597.517260687647, 4124.319487284564, 4158.230727315396, 4193.643540299109, 4210.073783767566, 4213.094184750232, 3359.3953088443827, 3455.36075825973, 3458.3774920514047, 3682.4660424238336, 3770.981145094312, 1137.4653912661036, 1156.6009726644295, 1189.4766302826729, 1236.462138969533, 1241.9379031048593, 857.8069934264865, 865.5585651317747, 868.1015149320423, 886.1006078829993, 890.5631122000225, 5321.6540924839765, 5350.063738845686, 5383.946160538345, 5576.386597474275, 5729.799457018984, 867.236831588211, 870.9085546017703, 882.1972005474987, 882.3823323673454, 902.0348227396622, 3801.82891769871, 3822.7132965027736, 3826.521684789401, 3925.646691797752, 3959.544652365015, 9461.858072128924, 9590.760230994281, 9779.902200978042, 9787.412755234567, 9788.363756355815, 9639.807203855884, 9701.6119355225, 9714.0, 9739.220862330996, 9755.853662195073, 7249.637518124073, 7435.925640743631, 7464.141623713343, 7475.813104672318, 7479.214682458372, 5284.207368894697, 5322.41453440129, 5444.237806707143, 5494.09347457665, 5501.944980550144, 9059.22996545301, 9072.228860546664, 9101.908980910372, 9117.680881169128, 9171.908280917372, 8573.485590864568, 8869.467831930106, 8888.022317545194, 9163.450192988443, 9231.630734770803, 6772.05191273232, 6922.93077069243, 6943.965280173769, 6945.687444064928, 6950.200726916267, 7448.627568621656, 7451.2176221495965, 7498.887516687363, 7515.060617422822, 7517.736879209201, 5986.132010858489, 6048.667323297261, 6726.764563240263, 6835.555688880406, 6913.239543650295, 6717.429018533479, 6725.293844146294, 6784.86430271382, 6796.422304104009, 6810.421114205348, 6477.417032466912, 6490.707918143789, 6530.216374035146, 6545.312742162195, 6546.378094081055, 4657.184992626345, 4715.952840471688, 4758.0, 4762.285657151317, 4810.062037902575, 4776.188048031912, 4856.223004319292, 4857.222844344888, 4863.2461968394955, 4946.0355230729665], "value": 4177.678388807551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5478118478727, 299.5506739890165, 305.8486049405543, 306.5539639824056, 306.8143773017325, 4808.879778005552, 4829.396325459317, 4839.903201935959, 4840.757962101899, 4852.393450818648, 4744.8410973007285, 4776.331313616097, 4794.832180873661, 4797.208460603996, 4797.592204662608, 3551.8579256829694, 3682.815859207042, 3683.1528748387886, 3684.5578530576367, 3706.8887933362043, 3668.779873207616, 3705.907352316187, 3777.7355585108917, 3801.144742432958, 3824.464574959508, 3696.3161815064163, 3739.8504059837574, 3762.0030691866677, 3764.494202319067, 3765.4351847222997, 3529.982350088259, 3709.610490898444, 3738.719596030309, 3744.1388480649466, 3748.231612519427, 3226.7902586332048, 3228.6287076986214, 3237.352529494087, 3238.4008958342783, 3239.6922292382187, 4652.511486293958, 4654.976725116387, 4657.2315567931255, 4663.2305669564485, 4669.299605059235, 4088.2845502037026, 4232.619064284229, 4234.322508398642, 4239.533651298355, 4247.660187185018, 4984.401871775374, 4988.226824842155, 5010.649254552182, 5015.297858299841, 5020.573251273646, 3577.177249232665, 3590.0, 3595.676389124991, 3596.8381422836037, 3597.6222496638, 5107.693538387709, 5221.190715439113, 5234.659747116425, 5244.501772331622, 5255.947440525584, 3608.1701208722143, 3614.3494171048937, 3621.6016238213774, 3626.7668992542663, 3627.782333060025, 3653.0, 3667.798271095062, 3668.321360548254, 3669.9633003670156, 3674.8713795017047, 4202.814536441095, 4206.170315912588, 4212.347086201644, 4218.156368726267, 4221.936670949938, 4908.852734417973, 5003.924941125886, 5004.3994720633755, 5007.873228523553, 5016.974915125401, 1270.3140304235794, 1280.3854150008049, 1281.2760790153534, 1282.8781265779735, 1284.1460428814921, 792.84935862186, 807.3097501636134, 820.9917900821035, 821.954792486407, 832.4963397144761, 4380.649548036149, 4440.578145076212, 4444.755538445352, 4450.688451808407, 4468.597826195658, 5170.45710200431, 5174.172132458789, 5174.767135478913, 5176.534111929869, 5199.66202196856, 4369.536833082507, 4425.225585522585, 4445.355423463579, 4451.755153466591, 4460.531644177379, 2624.2127361791386, 2732.6883096113975, 2732.9726702733115, 2733.510236920883, 2741.3831887825477, 4841.273808928619, 4843.927341089887, 4850.587700045465, 4872.658913875995, 4902.852914412573, 5019.648624596316, 5264.578833693296, 5278.9472105278455, 5281.709505977208, 5289.206619007103, 4910.45984941649, 4939.332760309465, 4943.332650092263, 4953.900921981613, 4957.529034741694, 5214.478552144907, 5222.764975576184, 5225.216217567396, 5228.562145409891, 5231.843044708665, 4864.610831133572, 5094.770735316845, 5128.1794912813775, 5129.256257842667, 5147.768350424315, 4868.3427737255015, 4876.414830220397, 4895.485973972682, 4923.359963204761, 4940.1466855852495, 3669.156094098319, 3697.4084146537502, 3704.2961837250837, 3713.405855063177, 3727.8508859645312, 5055.924161137512, 5224.4139151120435, 5229.267902493578, 5241.31862857826, 5252.9737351314525, 5051.722155281348, 5053.69677819332, 5068.315777370008, 5073.8731531712, 5085.466026067357, 5045.495450454925, 5049.671771334852, 5072.54347108762, 5081.949180508148, 5084.669496482717, 4868.632494365677, 4920.51513985435, 5015.924761128513, 5020.339220213293, 5021.623378246719, 4866.756662166807, 4939.87585338308, 5097.464766199496, 5107.923381149211, 5115.386153661584, 4956.281339205867, 4982.925256121233, 4991.101601711727, 4994.2508623706735, 4996.525330093636], "value": 3784.0732138750227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.5807692692042, 629.3989240275536, 644.2558844534565, 658.5061204096927, 710.9360157585817, 11563.364014979174, 12658.303793291365, 13760.105593136452, 13798.310084495784, 14291.857081429183, 13388.598342049754, 13886.652833679163, 13906.58280251594, 13913.652158696037, 13922.791158132635, 622.7166639179162, 750.4446709435019, 773.4663082473076, 774.4462709162948, 774.7404619452462, 629.1726379810557, 637.2766909557662, 637.4295005969655, 738.3908275672565, 759.1345865713091, 816.1960468938091, 816.5386556595535, 818.4761752478419, 818.6929901287017, 818.7625588579305, 802.0896282719098, 806.238104990784, 810.6554714246481, 810.7365106340463, 810.8459392715395, 586.7389011889711, 591.1516973143553, 591.2018774654225, 591.325888487125, 591.8313280714975, 12841.0, 12889.871101288962, 12900.870991290061, 12912.418941147671, 13021.414036368385, 13273.800892986614, 13311.866881331256, 13350.198988060747, 13505.459781608724, 13705.588832335046, 10251.179905607534, 10317.638882639147, 10325.89674103257, 10411.583536658525, 10483.423411712352, 3129.4523458394688, 3167.2398624329994, 3169.3344397676515, 3195.2650890295363, 3266.6080070391704, 59385.40614593842, 59527.107093393635, 60295.09557356687, 60377.396226037614, 60542.0, 9896.069360131976, 9946.055124763136, 10061.64784232563, 10247.333923294962, 10259.384436933808, 17589.912050439667, 18570.628587428175, 18594.349197778014, 18626.534336641693, 18664.906675466536, 6719.160104986877, 6931.202911665122, 6955.947995341387, 6956.130483689539, 7166.892496612555, 3746.438034294823, 3895.3183192941688, 3898.7270891037924, 3932.4494570760116, 4009.7393669411395, 2858.371158345161, 2980.5678176664264, 2982.6719060903283, 2984.1346009656954, 2985.0746268656353, 516.354556803995, 528.899509093271, 538.9919151212735, 542.1542393865583, 543.5108402437837, 551.9797540999921, 569.7920259105397, 578.1991941161438, 580.5297708855841, 609.7439075588263, 7636.31273185416, 8089.433739638169, 8296.751097466966, 8342.582870856433, 8465.703700370457, 472.3906161052273, 502.85668584453254, 532.3611666000814, 608.1698481572621, 611.3947192279611, 4375.934360984587, 4483.820647174077, 4576.954230457719, 4598.992137880258, 4626.167289887785, 101040.0, 103178.48410758049, 105357.47321263344, 106795.0, 107492.4625376868, 51811.0, 67511.0, 67769.66115169393, 68656.0, 82039.0, 64649.67675161594, 71933.2806671937, 72485.6375718118, 73180.26819731841, 73862.63068684623, 8526.0, 8609.0, 8790.129336647438, 8825.911740882766, 8901.55492225399, 37663.62336376601, 43573.78213109041, 43781.56218437775, 44276.77861610671, 45014.77492612516, 37819.81090094532, 41693.58306417018, 56219.0, 62770.68614656897, 63157.36842631515, 11526.250793698382, 11614.419279036183, 11808.350540720343, 11973.281603103842, 12401.069919755873, 13448.394822232827, 13476.460941562227, 13685.11046781956, 13852.445902163801, 13948.860511394756, 12300.200486968319, 12497.93751031239, 12863.163894346837, 12924.353782311035, 13743.725125497635, 11636.592719254786, 11645.941770291094, 11907.226030308002, 12379.381030948596, 12396.256224626552, 10973.3964631946, 11479.024282936043, 11542.538298467967, 12412.069094817743, 12419.0, 9723.951380243054, 9857.605695772088, 10035.598576056876, 10129.043839004255, 10144.74638134023, 10168.796624067329, 10297.845532317171, 10340.638077667245, 10380.32527885685, 10431.217658675781], "value": 6535.805287754469, "unit": "score"}], "name": "dromaeo_css", "value": 6268.780512648487, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 114.0, 117.0, 115.0, 113.0, 113.0, 114.0, 113.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 127.0, 126.0, 173.0, 123.0, 124.0, 152.0, 123.0, 185.0, 121.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 164.0, 162.0, 160.0, 161.0, 162.0, 162.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 104.0, 74.0, 77.0, 75.0, 76.0, 100.0, 74.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 120.0, 85.0, 85.0, 85.0, 118.0, 85.0, 85.0, 125.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.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, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 65.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 84.0, 78.0, 77.0, 80.0, 78.0, 79.0, 77.0, 86.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 128.0, 129.0, 130.0, 137.0, 128.0, 128.0, 170.0, 131.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 166.0, 165.0, 163.0, 164.0, 165.0, 165.0, 168.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 69.0, 71.0, 66.0, 64.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1526.6000000000001, "alertThreshold": 2.0}]} 23:56:32 INFO - Return code: 0 23:56:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:56:32 INFO - # TBPL SUCCESS # 23:56:32 INFO - Running post-action listener: _resource_record_post_action 23:56:32 INFO - ##### 23:56:32 INFO - ##### Finished run-tests step (success) 23:56:32 INFO - ##### 23:56:32 INFO - Running post-run listener: _resource_record_post_run 23:56:33 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 555159552; Read time: 96; Write time: 513336 23:56:33 INFO - TinderboxPrint: CPU usage
12.9% 23:56:33 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 96 23:56:33 INFO - TinderboxPrint: I/O write bytes / time
555,159,552 / 513,336 23:56:33 INFO - TinderboxPrint: CPU idle
8,336.5 (87.0%) 23:56:33 INFO - TinderboxPrint: CPU user
1,198.7 (12.5%) 23:56:33 INFO - TinderboxPrint: Swap in / out
0 / 0 23:56:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262082560; Read time: 0; Write time: 297836 23:56:33 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 289177600; Read time: 96; Write time: 214816 23:56:33 INFO - Running post-run listener: _upload_blobber_files 23:56:33 INFO - Blob upload gear active. 23:56:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:56:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:56:33 INFO - (blobuploader) - INFO - Open directory for files ... 23:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:34 INFO - (blobuploader) - INFO - Done attempting. 23:56:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:56:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:44 INFO - (blobuploader) - INFO - Done attempting. 23:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:46 INFO - (blobuploader) - INFO - Done attempting. 23:56:46 INFO - (blobuploader) - INFO - Iteration through files over. 23:56:46 INFO - Return code: 0 23:56:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:56:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:56:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/884319abb9014e0c1c71baa4036683633fa2a6f07b4e57ab12838c04d135135116cc4756e873b4feee214ee5abf1ed90fb3bf0b74efa444b064c2ce277dd1340", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/628e1c4e43ae616d8b1ee09f97e41608bbe5c634df3e43c487ed3f0cc7076ff4230e91e8b8c5e26c2bec244723537bbea2efbdc1cee3e4943260f30a393923f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f123a8deaecc07c80af45b64dc85a7354d06322805ddc1f9315ccbe32067d06651d35f48544fb8fc03a7e73d52ac2d25376f0cda780f664907917be745527d4"} 23:56:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:56:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:56:46 INFO - Contents: 23:56:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/884319abb9014e0c1c71baa4036683633fa2a6f07b4e57ab12838c04d135135116cc4756e873b4feee214ee5abf1ed90fb3bf0b74efa444b064c2ce277dd1340", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/628e1c4e43ae616d8b1ee09f97e41608bbe5c634df3e43c487ed3f0cc7076ff4230e91e8b8c5e26c2bec244723537bbea2efbdc1cee3e4943260f30a393923f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f123a8deaecc07c80af45b64dc85a7354d06322805ddc1f9315ccbe32067d06651d35f48544fb8fc03a7e73d52ac2d25376f0cda780f664907917be745527d4"} 23:56:46 INFO - Running post-run listener: copy_logs_to_upload_dir 23:56:46 INFO - Copying logs to upload dir... 23:56:46 INFO - mkdir: /builds/slave/test/build/upload/logs 23:56:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.592095 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-19 23:56:46.084134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 23:56:46.087817) ========= 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=00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212 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/884319abb9014e0c1c71baa4036683633fa2a6f07b4e57ab12838c04d135135116cc4756e873b4feee214ee5abf1ed90fb3bf0b74efa444b064c2ce277dd1340", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/628e1c4e43ae616d8b1ee09f97e41608bbe5c634df3e43c487ed3f0cc7076ff4230e91e8b8c5e26c2bec244723537bbea2efbdc1cee3e4943260f30a393923f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f123a8deaecc07c80af45b64dc85a7354d06322805ddc1f9315ccbe32067d06651d35f48544fb8fc03a7e73d52ac2d25376f0cda780f664907917be745527d4"} build_url:https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/LXonckjWT4C4faJnnTUnQA/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/884319abb9014e0c1c71baa4036683633fa2a6f07b4e57ab12838c04d135135116cc4756e873b4feee214ee5abf1ed90fb3bf0b74efa444b064c2ce277dd1340", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/628e1c4e43ae616d8b1ee09f97e41608bbe5c634df3e43c487ed3f0cc7076ff4230e91e8b8c5e26c2bec244723537bbea2efbdc1cee3e4943260f30a393923f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f123a8deaecc07c80af45b64dc85a7354d06322805ddc1f9315ccbe32067d06651d35f48544fb8fc03a7e73d52ac2d25376f0cda780f664907917be745527d4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 23:56:46.113483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:56:46.113851) ========= 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=00204705a9daa57ed339a427000001b9-1468995678.425105-1873913212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 23:56:46.196673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 23:56:46.196984) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 23:56:46.197276) ========= ========= Total master_lag: 0.18 =========