builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1468998598.52 results: success (0) buildid: 20160719232620 builduid: 2a7bf354a02541c3b73d3cba654c9a43 revision: d950882eb6ce5840a6bb65f7ff1d63e0941bc802 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.521388) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.521997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.522364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.538653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.538976) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 00:09: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-20 00:09:58 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.639220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.639721) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019391 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.690460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:58.690832) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d950882eb6ce5840a6bb65f7ff1d63e0941bc802 --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 d950882eb6ce5840a6bb65f7ff1d63e0941bc802 --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=e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 00:09:58,805 truncating revision to first 12 chars 2016-07-20 00:09:58,806 Setting DEBUG logging. 2016-07-20 00:09:58,806 attempt 1/10 2016-07-20 00:09:58,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d950882eb6ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 00:09:59,076 unpacking tar archive at: fx-team-d950882eb6ce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:59.384724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:59.385145) ========= script_repo_revision: d950882eb6ce5840a6bb65f7ff1d63e0941bc802 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:59.385625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:59.385900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 00:09:59.395770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-20 00:09:59.396147) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:09:59 INFO - MultiFileLogger online at 20160720 00:09:59 in /builds/slave/test 00:09: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 00:09:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:09:59 INFO - {'append_to_log': False, 00:09:59 INFO - 'base_work_dir': '/builds/slave/test', 00:09:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:09:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:09:59 INFO - 'branch': 'Fx-Team-Non-PGO', 00:09:59 INFO - 'buildbot_json_path': 'buildprops.json', 00:09:59 INFO - 'config_files': ('talos/linux_config.py',), 00:09:59 INFO - 'default_actions': ('clobber', 00:09:59 INFO - 'read-buildbot-config', 00:09:59 INFO - 'download-and-extract', 00:09:59 INFO - 'populate-webroot', 00:09:59 INFO - 'create-virtualenv', 00:09:59 INFO - 'install', 00:09:59 INFO - 'run-tests'), 00:09:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:09:59 INFO - 'download_minidump_stackwalk': True, 00:09:59 INFO - 'download_symbols': 'ondemand', 00:09:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:09:59 INFO - 'tooltool.py': '/tools/tooltool.py', 00:09:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:09:59 INFO - '/tools/misc-python/virtualenv.py')}, 00:09:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:09:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:09:59 INFO - 'installer_path': 'installer.exe', 00:09:59 INFO - 'log_level': 'info', 00:09:59 INFO - 'log_name': 'talos', 00:09:59 INFO - 'log_to_console': True, 00:09:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:09:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:09:59 INFO - 'opt_config_files': (), 00:09:59 INFO - 'pip_index': False, 00:09:59 INFO - 'sps_profile': False, 00:09:59 INFO - 'sps_profile_interval': 0, 00:09:59 INFO - 'suite': 'dromaeojs', 00:09:59 INFO - 'system_bits': '32', 00:09:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:09:59 INFO - 'title': 'talos-linux64-ix-006', 00:09:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:09:59 INFO - 'use_talos_json': True, 00:09:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:09:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:09:59 INFO - 'work_dir': 'build'} 00:09:59 INFO - ##### 00:09:59 INFO - ##### Running clobber step. 00:09:59 INFO - ##### 00:09:59 INFO - Running pre-action listener: _resource_record_pre_action 00:09:59 INFO - Running main action method: clobber 00:09:59 INFO - rmtree: /builds/slave/test/build 00:09:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:10:00 INFO - Running post-action listener: _resource_record_post_action 00:10:00 INFO - ##### 00:10:00 INFO - ##### Finished clobber step (success) 00:10:00 INFO - ##### 00:10:00 INFO - ##### 00:10:00 INFO - ##### Running read-buildbot-config step. 00:10:00 INFO - ##### 00:10:00 INFO - Running pre-action listener: _resource_record_pre_action 00:10:00 INFO - Running main action method: read_buildbot_config 00:10:00 INFO - Using buildbot properties: 00:10:00 INFO - { 00:10:00 INFO - "project": "", 00:10:00 INFO - "product": "firefox", 00:10:00 INFO - "script_repo_revision": "production", 00:10:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:10:00 INFO - "repository": "", 00:10:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:10:00 INFO - "buildid": "20160719232620", 00:10:00 INFO - "pgo_build": "False", 00:10:00 INFO - "basedir": "/builds/slave/test", 00:10:00 INFO - "buildnumber": 2004, 00:10:00 INFO - "slavename": "talos-linux64-ix-006", 00:10:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:10:00 INFO - "platform": "ubuntu64_hw", 00:10:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:10:00 INFO - "branch": "fx-team", 00:10:00 INFO - "repo_path": "integration/fx-team", 00:10:00 INFO - "revision": "d950882eb6ce5840a6bb65f7ff1d63e0941bc802", 00:10:00 INFO - "stage_platform": "linux64", 00:10:00 INFO - "builduid": "2a7bf354a02541c3b73d3cba654c9a43", 00:10:00 INFO - "slavebuilddir": "test" 00:10:00 INFO - } 00:10:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:10:00 INFO - Running post-action listener: _resource_record_post_action 00:10:00 INFO - ##### 00:10:00 INFO - ##### Finished read-buildbot-config step (success) 00:10:00 INFO - ##### 00:10:00 INFO - ##### 00:10:00 INFO - ##### Running download-and-extract step. 00:10:00 INFO - ##### 00:10:00 INFO - Running pre-action listener: _resource_record_pre_action 00:10:00 INFO - Running main action method: download_and_extract 00:10:00 INFO - mkdir: /builds/slave/test/build/tests 00:10: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')]} 00:10:00 INFO - https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:01 INFO - Downloaded 1361 bytes. 00:10:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:10:01 INFO - Using the following test package requirements: 00:10:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:10:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:10:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:10:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'jsshell-linux-x86_64.zip'], 00:10:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:10:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:10:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:10:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:10:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:10:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:10:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:10:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:10: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')]} 00:10:01 INFO - https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:02 INFO - Downloaded 22763363 bytes. 00:10: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'] 00:10: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 00:10:03 INFO - Return code: 0 00:10: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 00:10: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')]} 00:10:03 INFO - https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:04 INFO - Downloaded 22763363 bytes. 00:10: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'] 00:10: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 00:10:05 INFO - Return code: 0 00:10: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')]} 00:10:05 INFO - https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:07 INFO - Downloaded 14403317 bytes. 00:10: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'] 00:10: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 00:10:07 INFO - Return code: 0 00:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:07 INFO - https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hli0Y5AnTGihiYI2ewWjew/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 00:10:08 INFO - Downloaded 57119721 bytes. 00:10:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:10:08 INFO - mkdir: /builds/slave/test/properties 00:10:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:10:08 INFO - Writing to file /builds/slave/test/properties/build_url 00:10:08 INFO - Contents: 00:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:10:09 INFO - Running post-action listener: _resource_record_post_action 00:10:09 INFO - Running post-action listener: set_extra_try_arguments 00:10:09 INFO - ##### 00:10:09 INFO - ##### Finished download-and-extract step (success) 00:10:09 INFO - ##### 00:10:09 INFO - ##### 00:10:09 INFO - ##### Running populate-webroot step. 00:10:09 INFO - ##### 00:10:09 INFO - Running pre-action listener: _resource_record_pre_action 00:10:09 INFO - Running main action method: populate_webroot 00:10:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:10:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:10:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:10:09 INFO - '--tppagecycles', 00:10:09 INFO - '7'], 00:10:09 INFO - 'tests': ['tsvgm']}}, 00:10:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:10:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:10:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:10:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:10:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:10:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:10:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['damp', 'tps']}, 00:10:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'tests': ['damp', 'tps']}, 00:10:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['dromaeo_dom']}, 00:10:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:10:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['basic_compositor_video']}, 00:10:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:10:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['a11yr', 00:10:09 INFO - 'ts_paint', 00:10:09 INFO - 'tpaint', 00:10:09 INFO - 'sessionrestore', 00:10:09 INFO - 'sessionrestore_no_auto_restore', 00:10:09 INFO - 'tabpaint']}, 00:10:09 INFO - 'other-e10s': {'tests': ['a11yr', 00:10:09 INFO - 'ts_paint', 00:10:09 INFO - 'tpaint', 00:10:09 INFO - 'sessionrestore', 00:10:09 INFO - 'sessionrestore_no_auto_restore', 00:10:09 INFO - 'tabpaint']}, 00:10:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:10:09 INFO - 'ts_paint', 00:10:09 INFO - 'tpaint', 00:10:09 INFO - 'sessionrestore', 00:10:09 INFO - 'sessionrestore_no_auto_restore', 00:10:09 INFO - 'tabpaint']}, 00:10:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:10:09 INFO - 'ts_paint', 00:10:09 INFO - 'tpaint', 00:10:09 INFO - 'sessionrestore', 00:10:09 INFO - 'sessionrestore_no_auto_restore', 00:10:09 INFO - 'tabpaint']}, 00:10:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['a11yr', 00:10:09 INFO - 'ts_paint', 00:10:09 INFO - 'tpaint', 00:10:09 INFO - 'sessionrestore', 00:10:09 INFO - 'sessionrestore_no_auto_restore', 00:10:09 INFO - 'tabpaint']}, 00:10:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['a11yr', 00:10:09 INFO - 'ts_paint', 00:10:09 INFO - 'tpaint', 00:10:09 INFO - 'sessionrestore', 00:10:09 INFO - 'sessionrestore_no_auto_restore', 00:10:09 INFO - 'tabpaint']}, 00:10:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['tsvgx', 00:10:09 INFO - 'tsvgr_opacity', 00:10:09 INFO - 'tart', 00:10:09 INFO - 'tscrollx', 00:10:09 INFO - 'cart']}, 00:10:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:10:09 INFO - 'tsvgr_opacity', 00:10:09 INFO - 'tart', 00:10:09 INFO - 'tscrollx', 00:10:09 INFO - 'cart']}, 00:10:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'talos_options': ['--disable-e10s'], 00:10:09 INFO - 'tests': ['tp5o']}, 00:10:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'tests': ['tp5o']}, 00:10:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'talos_options': ['--disable-e10s', 00:10:09 INFO - '--xperf_path', 00:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:10:09 INFO - 'tests': ['tp5n']}, 00:10:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:10:09 INFO - 'talos_options': ['--xperf_path', 00:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:10:09 INFO - 'tests': ['tp5n']}}, 00:10:09 INFO - 'talos.zip': {'path': '', 00:10:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:10:09 INFO - Running post-action listener: _resource_record_post_action 00:10:09 INFO - ##### 00:10:09 INFO - ##### Finished populate-webroot step (success) 00:10:09 INFO - ##### 00:10:09 INFO - ##### 00:10:09 INFO - ##### Running create-virtualenv step. 00:10:09 INFO - ##### 00:10:09 INFO - Running pre-action listener: _resource_record_pre_action 00:10:09 INFO - Running main action method: create_virtualenv 00:10:09 INFO - Creating virtualenv /builds/slave/test/build/venv 00:10:09 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 00:10:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:10:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:10:09 INFO - Using real prefix '/usr' 00:10:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:10:10 INFO - Installing distribute.............................................................................................................................................................................................done. 00:10:12 INFO - Installing pip.................done. 00:10:12 INFO - Return code: 0 00:10:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:10:12 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')]} 00:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:12 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')]} 00:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:12 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:12 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 00:10:12 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 00:10:12 INFO - Using env: {'DISPLAY': ':0', 00:10:12 INFO - 'HOME': '/home/cltbld', 00:10:12 INFO - 'LANG': 'en_US.UTF-8', 00:10:12 INFO - 'LANGUAGE': 'en_US:en', 00:10:12 INFO - 'LOGNAME': 'cltbld', 00:10:12 INFO - 'MAIL': '/var/mail/cltbld', 00:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:12 INFO - 'MOZ_NO_REMOTE': '1', 00:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:12 INFO - 'NO_EM_RESTART': '1', 00:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:12 INFO - 'PWD': '/builds/slave/test', 00:10:12 INFO - 'SHELL': '/bin/bash', 00:10:12 INFO - 'SHLVL': '1', 00:10:12 INFO - 'TERM': 'linux', 00:10:12 INFO - 'TMOUT': '86400', 00:10:12 INFO - 'USER': 'cltbld', 00:10:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:12 INFO - '_': '/tools/buildbot/bin/python'} 00:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:12 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 00:10:12 INFO - Cleaning up... 00:10:12 INFO - Return code: 0 00:10:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:10:12 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')]} 00:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:12 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')]} 00:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:12 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:12 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 00:10:12 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 00:10:12 INFO - Using env: {'DISPLAY': ':0', 00:10:12 INFO - 'HOME': '/home/cltbld', 00:10:12 INFO - 'LANG': 'en_US.UTF-8', 00:10:12 INFO - 'LANGUAGE': 'en_US:en', 00:10:12 INFO - 'LOGNAME': 'cltbld', 00:10:12 INFO - 'MAIL': '/var/mail/cltbld', 00:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:12 INFO - 'MOZ_NO_REMOTE': '1', 00:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:12 INFO - 'NO_EM_RESTART': '1', 00:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:12 INFO - 'PWD': '/builds/slave/test', 00:10:12 INFO - 'SHELL': '/bin/bash', 00:10:12 INFO - 'SHLVL': '1', 00:10:12 INFO - 'TERM': 'linux', 00:10:12 INFO - 'TMOUT': '86400', 00:10:12 INFO - 'USER': 'cltbld', 00:10:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:12 INFO - '_': '/tools/buildbot/bin/python'} 00:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:12 INFO - Downloading/unpacking psutil>=3.1.1 00:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:10:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:10:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:10:14 INFO - Installing collected packages: psutil 00:10:14 INFO - Running setup.py install for psutil 00:10:14 INFO - building 'psutil._psutil_linux' extension 00:10:14 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 00:10:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:10:15 INFO - building 'psutil._psutil_posix' extension 00:10:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:10:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:10:15 INFO - Successfully installed psutil 00:10:15 INFO - Cleaning up... 00:10:15 INFO - Return code: 0 00:10:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:10:15 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')]} 00:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:15 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')]} 00:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:15 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:15 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 00:10:15 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 00:10:15 INFO - Using env: {'DISPLAY': ':0', 00:10:15 INFO - 'HOME': '/home/cltbld', 00:10:15 INFO - 'LANG': 'en_US.UTF-8', 00:10:15 INFO - 'LANGUAGE': 'en_US:en', 00:10:15 INFO - 'LOGNAME': 'cltbld', 00:10:15 INFO - 'MAIL': '/var/mail/cltbld', 00:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:15 INFO - 'MOZ_NO_REMOTE': '1', 00:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:15 INFO - 'NO_EM_RESTART': '1', 00:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:15 INFO - 'PWD': '/builds/slave/test', 00:10:15 INFO - 'SHELL': '/bin/bash', 00:10:15 INFO - 'SHLVL': '1', 00:10:15 INFO - 'TERM': 'linux', 00:10:15 INFO - 'TMOUT': '86400', 00:10:15 INFO - 'USER': 'cltbld', 00:10:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:15 INFO - '_': '/tools/buildbot/bin/python'} 00:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:10:15 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 00:10:15 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 00:10:15 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 00:10:15 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 00:10:15 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 00:10:15 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 00:10:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:10:17 INFO - Installing collected packages: mozsystemmonitor 00:10:17 INFO - Running setup.py install for mozsystemmonitor 00:10:17 INFO - Successfully installed mozsystemmonitor 00:10:17 INFO - Cleaning up... 00:10:17 INFO - Return code: 0 00:10:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:10:17 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')]} 00:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:17 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')]} 00:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:17 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:17 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 00:10:17 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 00:10:17 INFO - Using env: {'DISPLAY': ':0', 00:10:17 INFO - 'HOME': '/home/cltbld', 00:10:17 INFO - 'LANG': 'en_US.UTF-8', 00:10:17 INFO - 'LANGUAGE': 'en_US:en', 00:10:17 INFO - 'LOGNAME': 'cltbld', 00:10:17 INFO - 'MAIL': '/var/mail/cltbld', 00:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:17 INFO - 'MOZ_NO_REMOTE': '1', 00:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:17 INFO - 'NO_EM_RESTART': '1', 00:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:17 INFO - 'PWD': '/builds/slave/test', 00:10:17 INFO - 'SHELL': '/bin/bash', 00:10:17 INFO - 'SHLVL': '1', 00:10:17 INFO - 'TERM': 'linux', 00:10:17 INFO - 'TMOUT': '86400', 00:10:17 INFO - 'USER': 'cltbld', 00:10:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:17 INFO - '_': '/tools/buildbot/bin/python'} 00:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:17 INFO - Downloading/unpacking jsonschema==2.5.1 00:10: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 00:10: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 00:10: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 00:10: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 00:10: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 00:10: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 00:10:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:10:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:10: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 00:10: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 00:10: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 00:10: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 00:10: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 00:10: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 00:10:20 INFO - Downloading functools32-3.2.3-2.tar.gz 00:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:10:20 INFO - warning: no files found matching '*.txt' 00:10:20 INFO - no previously-included directories found matching 'build' 00:10:20 INFO - no previously-included directories found matching 'dist' 00:10:20 INFO - no previously-included directories found matching '.git*' 00:10:20 INFO - Installing collected packages: jsonschema, functools32 00:10:20 INFO - Running setup.py install for functools32 00:10:20 INFO - warning: no files found matching '*.txt' 00:10:20 INFO - no previously-included directories found matching 'build' 00:10:20 INFO - no previously-included directories found matching 'dist' 00:10:20 INFO - no previously-included directories found matching '.git*' 00:10:20 INFO - Successfully installed jsonschema functools32 00:10:20 INFO - Cleaning up... 00:10:20 INFO - Return code: 0 00:10:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:10:20 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')]} 00:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:20 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')]} 00:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:20 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:20 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 00:10:20 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 00:10:20 INFO - Using env: {'DISPLAY': ':0', 00:10:20 INFO - 'HOME': '/home/cltbld', 00:10:20 INFO - 'LANG': 'en_US.UTF-8', 00:10:20 INFO - 'LANGUAGE': 'en_US:en', 00:10:20 INFO - 'LOGNAME': 'cltbld', 00:10:20 INFO - 'MAIL': '/var/mail/cltbld', 00:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:20 INFO - 'MOZ_NO_REMOTE': '1', 00:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:20 INFO - 'NO_EM_RESTART': '1', 00:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:20 INFO - 'PWD': '/builds/slave/test', 00:10:20 INFO - 'SHELL': '/bin/bash', 00:10:20 INFO - 'SHLVL': '1', 00:10:20 INFO - 'TERM': 'linux', 00:10:20 INFO - 'TMOUT': '86400', 00:10:20 INFO - 'USER': 'cltbld', 00:10:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:20 INFO - '_': '/tools/buildbot/bin/python'} 00:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:20 INFO - Downloading/unpacking blobuploader==1.2.4 00:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:25 INFO - Downloading blobuploader-1.2.4.tar.gz 00:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:10:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:10:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:26 INFO - Downloading docopt-0.6.1.tar.gz 00:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:10:26 INFO - Installing collected packages: blobuploader, requests, docopt 00:10:26 INFO - Running setup.py install for blobuploader 00:10:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:10:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:10:26 INFO - Running setup.py install for requests 00:10:27 INFO - Running setup.py install for docopt 00:10:27 INFO - Successfully installed blobuploader requests docopt 00:10:27 INFO - Cleaning up... 00:10:27 INFO - Return code: 0 00:10:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:27 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:27 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 00:10:27 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 00:10:27 INFO - Using env: {'DISPLAY': ':0', 00:10:27 INFO - 'HOME': '/home/cltbld', 00:10:27 INFO - 'LANG': 'en_US.UTF-8', 00:10:27 INFO - 'LANGUAGE': 'en_US:en', 00:10:27 INFO - 'LOGNAME': 'cltbld', 00:10:27 INFO - 'MAIL': '/var/mail/cltbld', 00:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:27 INFO - 'MOZ_NO_REMOTE': '1', 00:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:27 INFO - 'NO_EM_RESTART': '1', 00:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:27 INFO - 'PWD': '/builds/slave/test', 00:10:27 INFO - 'SHELL': '/bin/bash', 00:10:27 INFO - 'SHLVL': '1', 00:10:27 INFO - 'TERM': 'linux', 00:10:27 INFO - 'TMOUT': '86400', 00:10:27 INFO - 'USER': 'cltbld', 00:10:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:27 INFO - '_': '/tools/buildbot/bin/python'} 00:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:10:27 INFO - Running setup.py (path:/tmp/pip-_dj9ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:10:27 INFO - Running setup.py (path:/tmp/pip-M9YkE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:10:27 INFO - Running setup.py (path:/tmp/pip-jF3iO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:10:27 INFO - Running setup.py (path:/tmp/pip-LvBh18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:10:27 INFO - Running setup.py (path:/tmp/pip-t2vjjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:10:27 INFO - Running setup.py (path:/tmp/pip-b5hVlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:10:27 INFO - Running setup.py (path:/tmp/pip-VqR_Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:10:27 INFO - Running setup.py (path:/tmp/pip-1vZPuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:10:27 INFO - Running setup.py (path:/tmp/pip-UEVt7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:10:28 INFO - Running setup.py (path:/tmp/pip-Up0rnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:10:28 INFO - Running setup.py (path:/tmp/pip-_aZpb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:10:28 INFO - Running setup.py (path:/tmp/pip-ped4Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:10:28 INFO - Running setup.py (path:/tmp/pip-VZt7wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:10:28 INFO - Running setup.py (path:/tmp/pip-ivVt_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:10:28 INFO - Running setup.py (path:/tmp/pip-MoLJtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:10:28 INFO - Running setup.py (path:/tmp/pip-Q2whLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:10:28 INFO - Running setup.py (path:/tmp/pip-4KETLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:10:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:10:28 INFO - Running setup.py install for manifestparser 00:10:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:10:28 INFO - Running setup.py install for mozcrash 00:10:28 INFO - Running setup.py install for mozdebug 00:10:28 INFO - Running setup.py install for mozdevice 00:10:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Running setup.py install for mozfile 00:10:29 INFO - Running setup.py install for mozhttpd 00:10:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Running setup.py install for mozinfo 00:10:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Running setup.py install for mozInstall 00:10:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Running setup.py install for mozleak 00:10:29 INFO - Running setup.py install for mozlog 00:10:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Running setup.py install for moznetwork 00:10:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Running setup.py install for mozprocess 00:10:29 INFO - Running setup.py install for mozprofile 00:10:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:10:29 INFO - Running setup.py install for mozrunner 00:10:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:10:30 INFO - Running setup.py install for mozscreenshot 00:10:30 INFO - Running setup.py install for moztest 00:10:30 INFO - Running setup.py install for mozversion 00:10:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:10:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:10:30 INFO - Cleaning up... 00:10:30 INFO - Return code: 0 00:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:10:30 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')]} 00:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:30 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')]} 00:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:30 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:30 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 00:10:30 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 00:10:30 INFO - Using env: {'DISPLAY': ':0', 00:10:30 INFO - 'HOME': '/home/cltbld', 00:10:30 INFO - 'LANG': 'en_US.UTF-8', 00:10:30 INFO - 'LANGUAGE': 'en_US:en', 00:10:30 INFO - 'LOGNAME': 'cltbld', 00:10:30 INFO - 'MAIL': '/var/mail/cltbld', 00:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:30 INFO - 'MOZ_NO_REMOTE': '1', 00:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:30 INFO - 'NO_EM_RESTART': '1', 00:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:30 INFO - 'PWD': '/builds/slave/test', 00:10:30 INFO - 'SHELL': '/bin/bash', 00:10:30 INFO - 'SHLVL': '1', 00:10:30 INFO - 'TERM': 'linux', 00:10:30 INFO - 'TMOUT': '86400', 00:10:30 INFO - 'USER': 'cltbld', 00:10:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:30 INFO - '_': '/tools/buildbot/bin/python'} 00:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:10:30 INFO - Running setup.py (path:/tmp/pip-8nbtCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:10:30 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)) 00:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:10:30 INFO - Running setup.py (path:/tmp/pip-HYWbVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:10:30 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)) 00:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:10:30 INFO - Running setup.py (path:/tmp/pip-gCHiOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:10:30 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)) 00:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:10:30 INFO - Running setup.py (path:/tmp/pip-hkdy8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:10:30 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)) 00:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:10:30 INFO - Running setup.py (path:/tmp/pip-GAxJQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:10:31 INFO - Running setup.py (path:/tmp/pip-xMe23i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:10:31 INFO - Running setup.py (path:/tmp/pip-QrZ1CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:10:31 INFO - Running setup.py (path:/tmp/pip-wadk01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:10:31 INFO - Running setup.py (path:/tmp/pip-xR28st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:10:31 INFO - Running setup.py (path:/tmp/pip-1c4t0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:10:31 INFO - Running setup.py (path:/tmp/pip-1QPHYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:10:31 INFO - Running setup.py (path:/tmp/pip-XGeHjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:10:31 INFO - Running setup.py (path:/tmp/pip-5yREwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:10:31 INFO - Running setup.py (path:/tmp/pip-ikXBpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:10:31 INFO - Running setup.py (path:/tmp/pip-ukHYc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:10:31 INFO - Running setup.py (path:/tmp/pip-OeBTsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:10:31 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)) 00:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:10:31 INFO - Running setup.py (path:/tmp/pip-u7TjSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:10:31 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)) 00:10:31 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)) 00:10:31 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)) 00:10:31 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)) 00:10:31 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)) 00:10:31 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)) 00:10:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:10:31 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 00:10:31 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 00:10:31 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 00:10:31 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 00:10:31 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 00:10:31 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 00:10:33 INFO - Downloading blessings-1.6.tar.gz 00:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:10:33 INFO - Installing collected packages: blessings 00:10:33 INFO - Running setup.py install for blessings 00:10:33 INFO - Successfully installed blessings 00:10:33 INFO - Cleaning up... 00:10:34 INFO - Return code: 0 00:10:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:10:34 INFO - Reading from file tmpfile_stdout 00:10:34 INFO - Current package versions: 00:10:34 INFO - argparse == 1.2.1 00:10:34 INFO - blessings == 1.6 00:10:34 INFO - blobuploader == 1.2.4 00:10:34 INFO - docopt == 0.6.1 00:10:34 INFO - functools32 == 3.2.3-2 00:10:34 INFO - jsonschema == 2.5.1 00:10:34 INFO - manifestparser == 1.1 00:10:34 INFO - mozInstall == 1.12 00:10:34 INFO - mozcrash == 0.17 00:10:34 INFO - mozdebug == 0.1 00:10:34 INFO - mozdevice == 0.48 00:10:34 INFO - mozfile == 1.2 00:10:34 INFO - mozhttpd == 0.7 00:10:34 INFO - mozinfo == 0.9 00:10:34 INFO - mozleak == 0.1 00:10:34 INFO - mozlog == 3.2 00:10:34 INFO - moznetwork == 0.27 00:10:34 INFO - mozprocess == 0.23 00:10:34 INFO - mozprofile == 0.28 00:10:34 INFO - mozrunner == 6.12 00:10:34 INFO - mozscreenshot == 0.1 00:10:34 INFO - mozsystemmonitor == 0.3 00:10:34 INFO - moztest == 0.7 00:10:34 INFO - mozversion == 1.4 00:10:34 INFO - psutil == 3.1.1 00:10:34 INFO - requests == 1.2.3 00:10:34 INFO - wsgiref == 0.1.2 00:10:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:34 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:34 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 00:10:34 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 00:10:34 INFO - Using env: {'DISPLAY': ':0', 00:10:34 INFO - 'HOME': '/home/cltbld', 00:10:34 INFO - 'LANG': 'en_US.UTF-8', 00:10:34 INFO - 'LANGUAGE': 'en_US:en', 00:10:34 INFO - 'LOGNAME': 'cltbld', 00:10:34 INFO - 'MAIL': '/var/mail/cltbld', 00:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:34 INFO - 'MOZ_NO_REMOTE': '1', 00:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:34 INFO - 'NO_EM_RESTART': '1', 00:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:34 INFO - 'PWD': '/builds/slave/test', 00:10:34 INFO - 'SHELL': '/bin/bash', 00:10:34 INFO - 'SHLVL': '1', 00:10:34 INFO - 'TERM': 'linux', 00:10:34 INFO - 'TMOUT': '86400', 00:10:34 INFO - 'USER': 'cltbld', 00:10:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:34 INFO - '_': '/tools/buildbot/bin/python'} 00:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 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)) 00:10:34 INFO - Cleaning up... 00:10:34 INFO - Return code: 0 00:10:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:34 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 0x1e61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2122180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', '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 00:10:34 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 00:10:34 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 00:10:34 INFO - Using env: {'DISPLAY': ':0', 00:10:34 INFO - 'HOME': '/home/cltbld', 00:10:34 INFO - 'LANG': 'en_US.UTF-8', 00:10:34 INFO - 'LANGUAGE': 'en_US:en', 00:10:34 INFO - 'LOGNAME': 'cltbld', 00:10:34 INFO - 'MAIL': '/var/mail/cltbld', 00:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:34 INFO - 'MOZ_NO_REMOTE': '1', 00:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:34 INFO - 'NO_EM_RESTART': '1', 00:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:34 INFO - 'PWD': '/builds/slave/test', 00:10:34 INFO - 'SHELL': '/bin/bash', 00:10:34 INFO - 'SHLVL': '1', 00:10:34 INFO - 'TERM': 'linux', 00:10:34 INFO - 'TMOUT': '86400', 00:10:34 INFO - 'USER': 'cltbld', 00:10:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:34 INFO - '_': '/tools/buildbot/bin/python'} 00:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:10:34 INFO - Cleaning up... 00:10:34 INFO - Return code: 0 00:10:34 INFO - Running post-action listener: _resource_record_post_action 00:10:34 INFO - Running post-action listener: _start_resource_monitoring 00:10:34 INFO - Starting resource monitoring. 00:10:34 INFO - ##### 00:10:34 INFO - ##### Finished create-virtualenv step (success) 00:10:34 INFO - ##### 00:10:34 INFO - ##### 00:10:34 INFO - ##### Running install step. 00:10:34 INFO - ##### 00:10:34 INFO - Running pre-action listener: _resource_record_pre_action 00:10:34 INFO - Running main action method: install 00:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:10:34 INFO - Reading from file tmpfile_stdout 00:10:34 INFO - Detecting whether we're running mozinstall >=1.0... 00:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:10:34 INFO - Reading from file tmpfile_stdout 00:10:34 INFO - Output received: 00:10:34 INFO - Usage: mozinstall [options] installer 00:10:34 INFO - Options: 00:10:34 INFO - -h, --help show this help message and exit 00:10:34 INFO - -d DEST, --destination=DEST 00:10:34 INFO - Directory to install application into. [default: 00:10:34 INFO - "/builds/slave/test"] 00:10:34 INFO - --app=APP Application being installed. [default: firefox] 00:10:34 INFO - mkdir: /builds/slave/test/build/application 00:10:34 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'] 00:10:34 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 00:10:51 INFO - Reading from file tmpfile_stdout 00:10:51 INFO - Output received: 00:10:51 INFO - /builds/slave/test/build/application/firefox/firefox 00:10:51 INFO - Running post-action listener: _resource_record_post_action 00:10:51 INFO - ##### 00:10:51 INFO - ##### Finished install step (success) 00:10:51 INFO - ##### 00:10:51 INFO - ##### 00:10:51 INFO - ##### Running run-tests step. 00:10:51 INFO - ##### 00:10:51 INFO - Running pre-action listener: _resource_record_pre_action 00:10:51 INFO - Running main action method: run_tests 00:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:10:51 INFO - Python 2.7.3 00:10:51 INFO - Return code: 0 00:10:51 INFO - grabbing minidump binary from tooltool 00:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21203b0>, '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 0x21212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2121740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:10:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:10:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:10:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:10:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:10:51 INFO - Return code: 0 00:10:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:10:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:10:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:10:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:10:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:10:51 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/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 00:10:51 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/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 00:10:51 INFO - Using env: {'DISPLAY': ':0', 00:10:51 INFO - 'HOME': '/home/cltbld', 00:10:51 INFO - 'LANG': 'en_US.UTF-8', 00:10:51 INFO - 'LANGUAGE': 'en_US:en', 00:10:51 INFO - 'LOGNAME': 'cltbld', 00:10:51 INFO - 'MAIL': '/var/mail/cltbld', 00:10:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:10:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:51 INFO - 'MOZ_NO_REMOTE': '1', 00:10:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:51 INFO - 'NO_EM_RESTART': '1', 00:10:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:51 INFO - 'PWD': '/builds/slave/test', 00:10:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:10:51 INFO - 'SHELL': '/bin/bash', 00:10:51 INFO - 'SHLVL': '1', 00:10:51 INFO - 'TERM': 'linux', 00:10:51 INFO - 'TMOUT': '86400', 00:10:51 INFO - 'USER': 'cltbld', 00:10:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595', 00:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:51 INFO - '_': '/tools/buildbot/bin/python'} 00:10:51 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/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 00:10:51 INFO - mozversion application_buildid: 20160719232620 00:10:51 INFO - mozversion application_changeset: d950882eb6ce5840a6bb65f7ff1d63e0941bc802 00:10:51 INFO - mozversion application_display_name: Nightly 00:10:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:10:51 INFO - mozversion application_name: Firefox 00:10:51 INFO - mozversion application_remotingname: firefox 00:10:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:10:51 INFO - mozversion application_vendor: Mozilla 00:10:51 INFO - mozversion application_version: 50.0a1 00:10:51 INFO - mozversion platform_buildid: 20160719232620 00:10:51 INFO - mozversion platform_changeset: d950882eb6ce5840a6bb65f7ff1d63e0941bc802 00:10:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:10:51 INFO - mozversion platform_version: 50.0a1 00:10:51 INFO - using testdate: 1468998651 00:10:51 INFO - actual date: 1468998651 00:10:51 INFO - starting webserver on 'localhost:48038' 00:10:51 INFO - SUITE-START | Running 2 tests 00:10:51 INFO - TEST-START | dromaeo_css 00:10:51 INFO - operating with platform_type : linux_ 00:10:51 INFO - Initialising browser for dromaeo_css test... 00:10:51 INFO - TEST-INFO | started process 18961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpecbJxS/profile http://localhost:48038/getInfo.html) 00:10:55 INFO - PROCESS | 18961 | __metrics Screen width/height:1600/1200 00:10:55 INFO - PROCESS | 18961 | colorDepth:24 00:10:55 INFO - PROCESS | 18961 | Browser inner width/height: 1024/697 00:10:55 INFO - PROCESS | 18961 | __metrics 00:10:56 INFO - PROCESS | 18961 | 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" 00:10:56 INFO - PROCESS | 18961 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:10:57 INFO - PROCESS | 18961 | console.error: PushService: 00:10:57 INFO - PROCESS | 18961 | stateChangeProcessEnqueue: Error transitioning state 00:10:57 INFO - PROCESS | 18961 | UnknownError 00:10:57 INFO - TEST-INFO | 18961: exit 0 00:10:57 INFO - Browser initialized. 00:10:57 INFO - Running cycle 1/1 for dromaeo_css test... 00:10:57 INFO - TEST-INFO | started process 19041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpecbJxS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:11:09 INFO - PROCESS | 19041 | RSS: Main: 159711232 00:11:09 INFO - PROCESS | 19041 | 00:12:01 INFO - PROCESS | 19041 | 1468998721577 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] 00:14:13 INFO - PROCESS | 19041 | Cycle 1(1): loaded http://localhost:48038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48038/tests/dromaeo/cssquery-ext.html) 00:14:14 INFO - PROCESS | 19041 | RSS: Main: 259264512 00:14:14 INFO - PROCESS | 19041 | 00:17:17 INFO - PROCESS | 19041 | Cycle 1(1): loaded http://localhost:48038/tests/dromaeo/cssquery-ext.html (next: http://localhost:48038/tests/dromaeo/cssquery-jquery.html) 00:17:17 INFO - PROCESS | 19041 | RSS: Main: 248725504 00:17:17 INFO - PROCESS | 19041 | 00:20:19 INFO - PROCESS | 19041 | Cycle 1(1): loaded http://localhost:48038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48038/tests/dromaeo/cssquery-mootools.html) 00:20:20 INFO - PROCESS | 19041 | RSS: Main: 253063168 00:20:20 INFO - PROCESS | 19041 | 00:23:22 INFO - PROCESS | 19041 | Cycle 1(1): loaded http://localhost:48038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48038/tests/dromaeo/cssquery-prototype.html) 00:23:23 INFO - PROCESS | 19041 | RSS: Main: 246050816 00:23:23 INFO - PROCESS | 19041 | 00:26:26 INFO - PROCESS | 19041 | Cycle 1(1): loaded http://localhost:48038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48038/tests/dromaeo/cssquery-yui.html) 00:26:26 INFO - PROCESS | 19041 | RSS: Main: 219127808 00:26:26 INFO - PROCESS | 19041 | 00:29:29 INFO - PROCESS | 19041 | Cycle 1(1): loaded http://localhost:48038/tests/dromaeo/cssquery-yui.html (next: http://localhost:48038/tests/dromaeo/cssquery-dojo.html) 00:29:29 INFO - PROCESS | 19041 | RSS: Main: 273129472 00:29:29 INFO - PROCESS | 19041 | 00:29:29 INFO - PROCESS | 19041 | __start_tp_report 00:29:29 INFO - PROCESS | 19041 | _x_x_mozilla_page_load 00:29:29 INFO - PROCESS | 19041 | _x_x_mozilla_page_load_details 00:29:29 INFO - PROCESS | 19041 | |i|pagename|runs| 00:29:29 INFO - PROCESS | 19041 | |0;dojo.html;2603.648507451494;2618.1883616079003;2647.02060237712;2652.615370771237;2658.853763043032;4600.217962946299;4644.164050470914;4665.4168228971375;4703.6472264580125;4712.552307530784;4703.341532185488;4726.550977657117;4738.123447162277;4755.952440475594;4769;4126.401671757593;4293.720908140968;4380.08018316154;4407.779611019452;4491.573300536444;4402.669799765014;4431.180231657154;4450.154470650566;4454.754988475633;4472.776361181945;4218.810153543098;4245.936310955338;4297.935530967006;4301.2902871026245;4370.147821174856;4270.935935960932;4306.181825453154;4320.740755554645;4356.499002614708;4379;4330.501992270866;4337.414449049369;4350.912981740347;4382.8904277393;4393.824247030115;4567.177907976563;4686.297055441677;4746.240601503743;4752.049590081998;4762.9523704763205;5014.674046186986;5105.361829771278;5111.08000559899;5158.97420512895;5193.532582067632;5109.514596113363;5139.84580462583;5140.177571588528;5149.613778966593;5162.354705661793;4560.270356742905;4613.123506533748;4763.380760501147;4775.856724298276;4791.880202994883;5053.974730126326;5126.282320475062;5133.743312834418;5137.691738495702;5143.048536020848;4887.193613053877;4891.804327826918;4892;4938.851834444972;4942.481039490874;4948.876278093005;4961.603071754251;5003.5997120230295;5012.122878496249;5014.448410674823;4996.175631020841;5043.5460808527405;5049.495050494921;5055.545000949932;5059.443461219263;5016.423111342169;5028.874278143076;5030.496950304941;5058.620603454756;5071.87320316995;4228.5982831630945;4263.083437061046;4386.342048692722;4403.603675669206;4440.000999775025;3746.194568167857;3794.5636251830842;3796.4115562087923;3815.027168072124;3824.388097904322;4362.258416069276;4381.78091095444;4385.846495372647;4388.29787234041;4434.17967675981;4872.220444728897;4918.163912134945;5110.8466745997675;5110.948890511122;5148.0476111919415;4295.806688699016;4325.545817689161;4332.025294308755;4350.760708161081;4353.412289340962;4583.037562111927;4584.243599805995;4599;4609.608183304456;4624.28323609841;4665.2535594304745;4708.670393072452;4738.5261473853025;4745.572898439157;4754.952450475451;5029.9245511318095;5054.090263752413;5078.619103567321;5122.026814905156;5143.871403214949;4773.594244489257;4790.808367665394;4791.784369703302;4809.831655892027;4856.78144483492;4967.05625931072;5013.899722005613;5014.774335154853;5023.196288593954;5077.365329333833;4964.304997300309;5000.824971126139;5002;5049.2930989660745;5066.468020857904;4901.607871370353;4906.484819094087;4929.309896614549;4930.334404855299;4983.800647974185;4829.203181475017;4951.9752401237765;4974.825881094144;4977.651564390458;5021.020900924431;4835.879103022312;4875.8049678012485;4878.0975519529;4879.73161476108;4880.097182021337;4938.08645400602;4941.382327209099;4945.505449455026;4946.802127914843;4997.300377947017;4728.3380326753595;4779.761011949319;4818.518148185153;4828.66199366041;4837.685550439211 00:29:29 INFO - PROCESS | 19041 | |1;ext.html;578.436024875746;583.9941600583993;589.4930359890493;592.0852283222421;593.6883136353414;27590.31024224393;29959.700402995964;39483.40774888376;40682.389764153486;41001.38497922534;42022;42268.78865605676;42348.3647745284;42351;42419.57580424195;7637.885431718529;7836.882446763303;7842.098158711764;7846.960765196166;7853.725119620814;7513.849723005536;9931.950340248324;10225.23310751693;10237.18102551794;10653.360798352085;10327.690169294896;10402.895971040307;10419.218558608096;10423.166146708245;10436.895631043706;7505.136909255396;9966.501674916297;10202.540885660126;10278.640247591373;10279.537420816081;9791.412515249107;10103.242256830767;10118.241131915136;10119.544620492023;10119.544620492095;38373.232535349416;38652.033699157466;38726.419103713466;38764.612353876386;38860;3065.5401689746495;3196.824174670392;3233.094733474631;3330.7002369786837;3622.2031153146268;29608.407831843244;29705;30241.848790756125;30351.544726829114;31286.530702039487;3440.0195944155794;3455.51622772812;3469.9132521686906;3480.930381392358;3543.539339885824;253960;254492;254761;254839.72580137165;255312;28739.856300718362;29564.260893477403;53005;54391;54409.45590544123;32354.926282003173;32429;32461.35077298488;32516.83741581277;32547;14077.225752583707;14285.57143285703;14294.142351458946;14294.927880409012;14296.642583935485;10489.947550262352;11119.610813621484;11470.197086203885;11644.76710465786;11814.88185118155;7868.25251601097;7966.123726390092;7994.880076798852;8008.479448835807;8040.396970227256;3084.306031142975;3112.7042930921525;3116.4857798463;3143.701348371901;3181.984090079535;855.5465603230298;906.9047749986288;911.7310393433953;930.9767255818658;975.190591808797;28252.85873570619;28260.315270049312;28444.288892777433;28947.56578651322;29038.12885613435;934.1452570897688;978.5107446276861;1007.808516381885;1029.1098200056897;1037.6368271105205;15138.470153544793;15139.697206055816;15235.466758663615;15362.615318920885;15367.692646147014;408024;411038.834417484;411287;412986;413595;50027;51083.23375149376;51188.232176517384;51197.744011279705;51325.48674513207;1065.2170654568886;1113.3264375052977;1129.271619805221;1190.2798806721808;1197.8562572491358;19451.638385312894;31639;32051.519227211145;32193;32222.35555288834;47763.76118119526;48123.5187648119;48240.276395854795;48262.75868620635;48345.51654483551;343332;345647;346004;346188;346394;25300.92211222099;25330;26279.60580591331;26298.73701262963;26321;42132.57867421286;42665.36001959911;43307.35038974355;43557;44260.336094959246;36823.26353472969;37121.44317835181;37307.44038839474;37381.6261837389;37675;35496;36453;36794.63205367912;37026;37197.25605487929;35221.47167792434;35834.10414739652;36141;36308.455373168894;36386.45420318644;31537.52693709642;32774.82672636439;33131;33145.83427082849;33493.66506335003;25161.496770064863;25215.495690086464;25219.87390063038;25494.74505254998;25649.487010259316 00:29:30 INFO - PROCESS | 19041 | |2;jquery.html;350.3623405402169;368.8524590163934;370.13204036534324;377.61294672960213;396.33020195868977;12923.806142907852;17293.221805018773;17554.91222543887;18844.717329240073;19608.117634706436;16983.57541061474;17061;17168;17250.568735781613;17586.648267034652;5014.1726615108555;5409.783608655649;5413.891722165555;5418.891622167574;5419.214213938976;3798.7150963677695;5247.291615631898;5964.970175149118;6280.937190628104;6293.9370606293805;6103.755849766004;6322.39937205967;6356.173697419329;6361.300256971729;6367.745290188387;6323.462505687022;6345.682715864212;6349.619022858597;6356.77751278703;6397.616143031387;5345.732713364355;5509.944900550983;5510.504054635102;5511.9724401378135;5564.8052318169075;21031.47421314464;21241.68137477939;21473.785262147492;21769.129234830587;21835.781642183534;1973.4178417366911;2192.6601376786466;2521.2814347910758;2545;2613.163787587973;13371.331433428388;14199.503017394341;14428.639284017983;14909.627259318495;15063.397464101423;1869.242956602578;1912.1682068300333;1952.326447375653;1963.5974625201943;1988.8210061094571;77096;82770;83101.58449207715;83560.58219708863;83778.58110709468;14258.500952466615;14868.70262594742;16563;16640.6671866562;16944.23750931211;28790.856045719636;29119.854400728284;29136.41727165445;29238.269043273664;29255;9131.452112873249;9154.633814647472;9216.861747073799;9333.82649899024;9377.953110234404;7358.595277259802;7453.925460745323;7502.4748267621835;7707.152213256537;7763.378929685611;8434.409591328547;8548.700795472128;8652.697155599524;8671.956640216884;8676.392652514263;3310.155910242873;3331.6168640606156;3394.8273105212684;3409.8124603147066;3415.6072051713872;772.4901564967095;839.2907992746242;850.3112478891993;869.699953516036;929.3355250995571;16428.917855410647;17034;17042.403515876886;17472.912635436995;17559.648807023787;829.2453866981018;842.9620667069996;899.1098812175899;909.2907532124954;931.0735817861272;9374.343795934356;9467.905320946702;9513.809723805485;9571.808563828685;9745;422079;427852;428460;428752;431430;77940;79321;79845;80530.19469805344;80788.59605701934;970.4419958523877;988.2933702402817;995.2436148527026;996.960121595128;1000.6097621927308;11946;15132.638760741467;16378.918105409874;16485.58786030359;16702.49892503227;38222;38348.424773628976;38848.805755971036;38932.22135557216;39483.40774888321;44179.33730994102;44985.1002979932;47573.28640070471;48388.51611483981;49193.2621010678;4965.975170124127;6608.7026083825385;7683.116441609286;7874.960625196837;8233.629486672995;8623.142979392409;11796.351200684045;12044.75910481803;12226.327551984727;12267.325297108744;10359.689209323733;10475.371477711362;10537.947310263706;10605.045545900906;10734.624288149877;10396.948015259875;10545.261831671709;10579.523921423708;10842.620508282173;10877.292975956538;10694.25140240207;10728.678139655824;10736.73158171052;10950.39772812503;11055.944720276348;7828.334591559781;7890.802729931797;7914.841703166019;7916;8075.676972921017;10394.792104157723;10554.419506927192;10626;10762.63616720793;10764.461776910966 00:29:30 INFO - PROCESS | 19041 | |3;mootools.html;1369.8013788000744;1423.615623781579;1481.6814384907243;1695.9067251301174;1698.8980661160324;7342.779716608504;7801.726939557117;7870.173631768661;7874.055113386402;7874.330681892046;6567.34326567343;7376;7595.468317217783;7603.201663825302;7734.8453030939345;2170.9565808683856;2189.0805861538192;2195.1877805212093;2197.055266235518;2201.306588424649;2153.655415133579;2169.2624507667388;2209.6133176694093;2210.0165426385265;2211.557688462306;1846.704527275636;2090.6550419180817;2157.255746767363;2165.4586353411646;2192.5176461178517;2167.6640120781303;2170;2177.1291483406685;2192.1341070277153;2196.2203417786777;2194.089452877054;2200.559888022402;2205.38249290199;2206.393241858486;2206.911723531057;7912.327452166573;7970.163132871081;7978.441509094366;7983.28150466455;7984.281414672707;4488.955110448886;4591.3572099905705;4599.425071866017;4700.388949436586;4758.167320718895;2763.9447211055667;2803.1170181392795;2926.956095658567;2944.0873329267997;2948.0713575223735;896.6099746610246;916.509667327983;924.7734305095295;933.5752232734089;935.5696379665362;10326.948365258126;10398.844017339747;10407.843882341771;10453.581856725721;10487.213458990605;4034.2738307104414;4108.055147316074;4280.422143010716;4284.807183676742;4312.439382880206;8943.195112439911;8992.730218093468;8993.820123597623;8999.145081217273;9007.909920900838;4684.250519916797;4689.929651055237;4693.601043911238;4695.131400690883;4695.460022097434;4140.420341152241;4247.532771395144;4275.46556680415;4280.16536775332;4283.378910058086;3672.3022625701033;3731.7014638828828;3753.1367785409507;3820.7134464915243;3826.292135954802;1087.8857719939451;1206.4390058622782;1206.877603828448;1213.2114125818111;1213.2174747288127;665.7603262825379;810.2383759266271;856.9014563325172;873.8121303919688;878.7188099808;5361.249425080492;5626.718664066781;5660.349059858087;5753.798617048467;5838.241028666331;837.539353355652;842.6629348260623;858.2576071697937;890.3811850763657;894.2532984957634;3702.9629703702617;3709.3137769512186;3738.981305093457;3750.849966001384;3859.575446700917;9376.812463750686;9673.467959262309;9694.5152742364;9748.561314740853;9755.804883902283;8188.50868947865;9031.142041506046;9677.37097088687;9700.369475984038;9710.514474276259;7102.573845569283;7391.926080739231;7469;7471.327580517779;7496.175420703718;5585.636933599303;5621.747021383966;5689.601727879009;5719.48524632785;5721.713914304185;8870.645174193218;9026.232770214605;9026.81946361056;9029.593668284811;9043.864342035007;8707.825843482968;9016.954915225644;9257;9260.212881905114;9262.814743705223;6550.148480697479;6587.209534855656;6606;6661.500387471056;6676.566023208476;7510.812229694083;7532.359749421142;7537.585432801248;7586.165521792709;7587.62061896914;6652.201735791542;6793.72825086991;6873.931260687329;6961.756338528127;7008.264132266243;6850.8287292816085;6864.725410983505;6865.450763938773;6935.826604334932;6949.409300209539;6351.428371446407;6382.3617638237665;6423.486121110206;6444;6448.419642232222;4675.883102922454;4793.209120495079;4857.028594281087;4911.50884911506;4927.236278376714;4791.736454494897;4817.470078291315;4865.440474345495;4886.560209581155;4960.131976903956 00:29:30 INFO - PROCESS | 19041 | |4;prototype.html;301.0696946435514;302.4510513418147;305.5569424334715;308.4032397311203;311.53114562583306;4823.78292976816;4838.782254798538;4847.878803029926;4855.538723821236;4863.635227357945;4792.113459010076;4792.137415265251;4793.4487533933525;4813.253945638423;4818.373611430509;3599.892003239907;3682.926341473169;3694.8891533254045;3772.396416573335;3819.19796842662;3773.792441415721;3775.2826962876966;3792.4500947362617;3803.3914573668217;3830;3603.9279214415697;3745.494358261627;3759.191773768639;3787.8674246401383;3789.730440302488;3648.2338708871034;3742.58831528533;3766.9623303766884;3767.472553842464;3779.8110094495164;3302.207470207157;3319.502074688816;3324.7007769300635;3328.3842489139342;3341.365140623274;4687.1328804171335;4694.718316900997;4700.224462963607;4707.529247075299;4724.551167639069;4197.853075142355;4251.192273468062;4310.202612516695;4312.892177695551;4322.891927701832;4987.725675087869;5037.79848806051;5040.974795126038;5048.7223202723835;5054.292399064134;3620.565532136134;3647.854085836563;3658.0854786303425;3662.1393972416463;3668.853245870189;4997.42529609096;5228;5273.446288139767;5273.815416460444;5299.1786273127345;3645.234500754871;3652.160003199226;3655.8903232903053;3664.8900532984053;3680.6871415929945;3705.9073523161596;3713.4801127842125;3716.3682174030478;3720.4233343831747;3722.590515043343;4280.657547396201;4281.250781113293;4288.7212331199;4301.462317210348;4311.590398912098;4846.36997190363;5029.673071250357;5039.77321020555;5040.79836806531;5130.563902068291;1284.6017734502334;1289.6131160651767;1289.7098152915519;1291.6964513339358;1292.1923797626484;828.4035494443991;830.9584520773938;840.7435732101768;847.186700767258;850.8638617821242;4340.220509591052;4346.60908509274;4486.609151163085;4501.3022981437925;4505.459344878635;5191.858925350184;5198.4007996002;5215.452377500308;5219.947800521946;5235.502627250406;4291.527931927485;4460.888477788017;4467.642588592905;4469.709468884512;4526.207913615104;2770.279727270924;2770.321271288507;2774.7502724754463;2782.819116757404;2783.6381270435118;4922.606191504671;4934.629902757236;4937.580305674058;4937.851864444073;4945.876353091202;5215.29593504872;5318.468153184728;5319.723266416032;5342.557509472421;5355.518003379637;4872.269159626014;4883.926741098886;4892.755362231803;4909.607231421478;4920.384951881015;5190.870228244324;5198.298229739088;5225.634205605571;5235.345581802275;5239.66388570912;4931.076880016868;5073.44192138857;5098.668586541863;5123.1054454233235;5148.794048238028;4863.975680121577;4872.147374209429;4876.561414382694;4881.609471242221;4891.486393928729;3654.9269014619026;3688.7786732796117;3691.3171063353366;3700.9444858327684;3722.81385930697;4976.601871850171;5120.74396280177;5176.171812509981;5209.140491818807;5215.5827533797965;4996.725180115129;5002.499750024968;5027.622928280321;5036.521530454601;5077.263796749525;5053.494650534917;5073.3911930568565;5074.289599456005;5085.364329458817;5095.13382724945;4691.202495575692;4974.626902982219;4985.975070124626;5020.673656212334;5045.772940217773;4829.468758436639;4953.876153096201;5107.540321370946;5130.538251557377;5145.742712864417;5000.574951129195;5000.6249531284575;5018.197088465828;5026.84919452417;5039.748012599429 00:29:30 INFO - PROCESS | 19041 | |5;yui.html;667.8330417395654;681.3595220492737;682.7712716240062;722.8373615936413;734.7134617499173;12275.693107672312;13224.206547607151;13233.867661323384;13248;13261.403236854341;13010.154339967896;13094.672633184151;13127.277999710011;13186.604401867959;13192;605.0440304319166;615.6244690738646;741.3031750154837;757.3789492616044;764.2052265643724;740.2560426771088;766.6090293950069;768.320036767462;769.6228847864562;774.206438400641;799.7920540659412;815.4454970619976;818.6520728690313;818.8198596308832;819.0499021135485;642.88749468843;754.3098065270271;758.29478584916;771.1363273134069;774.024728841658;572.7308165162367;572.8109723791139;574.0499473371576;574.2420005592619;574.4829653312053;11999.64001079969;12047.03623710101;12049.819252711217;12050.15648904577;12063.577774777841;12236.327002014885;12576.11967162299;12746;12838.935805321007;12929.547465838745;11451.427428628618;11851.881481185164;12065.819012714815;12205.93897030518;12619.810702839464;4045.7977101144825;4112.239235741367;4131.29767939448;4131.752094874317;4177.248095342868;60456.69771651114;60526.39473605251;60764.696176519275;61326;61470;9630.903690963141;9811.75470613226;9994.300398972002;10306.948465257627;10316.48417579118;17311.220995055253;17509.7373539397;17516.29934802619;17533.386331478338;17587.73618395725;6847.281035491302;6857.27998560144;6938.826529336807;6969.54697944632;7030.578165310098;3484.216051388468;3591.2458383739186;3636.618155093677;3673.1184515716036;3732.104294969188;2770.9030183943464;2856.11460447262;2865.5128628133266;2867.4695181391508;2867.6702179249237;472.45195573135;477.7969363020702;479.60672248755685;495.4005653159645;501.1405439670909;568.5224411494364;581.3459857660132;591.0602142593211;596.6032588328712;610.1397030187503;8464.830703385898;8525.488470691778;8530.488170709777;8702.434341767765;8758.737237882873;571.9656820590778;582.9154772557955;591.7692100080972;602.2471910112359;631.848356394462;4076.8165432555606;4092.4475195848777;4106.342985122366;4212.68404869636;4290.678199135077;77816.61091694505;81618.18381816224;82032;96731.51634241783;103900;70354.2964570358;71192.64403677949;71592.64203678949;80929.19070809217;83387.17650407151;73262.26737732661;75046;75962.24037759552;76756;76840.23159768443;8670.271783133314;8846.33652476054;8886.11138886132;8950.820983580423;9211.447313161232;38950.690020170856;39422.21155576815;41252.96867578335;43332.35001474917;45742.313865292715;61938.38061619326;63031.36968630439;63580.68209658922;64701.35298646953;65401;11319.103224651322;11769.17615766888;11867.703307417383;11888.28670279786;12330;13379;13397.598072057854;13623.18260904349;13628.727425451238;13632.795508067586;11483.655490335303;11607.187496875138;12334.321612311409;13200.20798752078;13699.520516781864;12456.81314780261;12626.431810568363;12672.936635316764;12684.175528590613;13237.602871913858;11963.171904175482;12108.21296615717;12126.090543209471;12621;12650.240985540897;9901.207903367856;9911.752206194902;10430.843537347098;10675.626353077605;10806.35161890289;10312.226583006155;10608.840867386842;10758.11628623389;10912.290701104721;11027.338359698444 00:29:30 INFO - PROCESS | 19041 | __end_tp_report 00:29:30 INFO - PROCESS | 19041 | __start_cc_report 00:29:30 INFO - PROCESS | 19041 | _x_x_mozilla_cycle_collect,1019 00:29:30 INFO - PROCESS | 19041 | __end_cc_report 00:29:30 INFO - PROCESS | 19041 | __startTimestamp1468999769992__endTimestamp 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - PROCESS | 19041 | ------- Summary: start ------- 00:29:30 INFO - PROCESS | 19041 | Number of tests: 6 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - PROCESS | 19041 | [#0] dojo.html Cycles:165 Average:4672.76 Median:4790.81 stddev:485.21 (10.1%) stddev-sans-first:458.75 00:29:30 INFO - PROCESS | 19041 | Values: 2603.6 2618.2 2647.0 2652.6 2658.9 4600.2 4644.2 4665.4 4703.6 4712.6 4703.3 4726.6 4738.1 4756.0 4769.0 4126.4 4293.7 4380.1 4407.8 4491.6 4402.7 4431.2 4450.2 4454.8 4472.8 4218.8 4245.9 4297.9 4301.3 4370.1 4270.9 4306.2 4320.7 4356.5 4379.0 4330.5 4337.4 4350.9 4382.9 4393.8 4567.2 4686.3 4746.2 4752.0 4763.0 5014.7 5105.4 5111.1 5159.0 5193.5 5109.5 5139.8 5140.2 5149.6 5162.4 4560.3 4613.1 4763.4 4775.9 4791.9 5054.0 5126.3 5133.7 5137.7 5143.0 4887.2 4891.8 4892.0 4938.9 4942.5 4948.9 4961.6 5003.6 5012.1 5014.4 4996.2 5043.5 5049.5 5055.5 5059.4 5016.4 5028.9 5030.5 5058.6 5071.9 4228.6 4263.1 4386.3 4403.6 4440.0 3746.2 3794.6 3796.4 3815.0 3824.4 4362.3 4381.8 4385.8 4388.3 4434.2 4872.2 4918.2 5110.8 5110.9 5148.0 4295.8 4325.5 4332.0 4350.8 4353.4 4583.0 4584.2 4599.0 4609.6 4624.3 4665.3 4708.7 4738.5 4745.6 4755.0 5029.9 5054.1 5078.6 5122.0 5143.9 4773.6 4790.8 4791.8 4809.8 4856.8 4967.1 5013.9 5014.8 5023.2 5077.4 4964.3 5000.8 5002.0 5049.3 5066.5 4901.6 4906.5 4929.3 4930.3 4983.8 4829.2 4952.0 4974.8 4977.7 5021.0 4835.9 4875.8 4878.1 4879.7 4880.1 4938.1 4941.4 4945.5 4946.8 4997.3 4728.3 4779.8 4818.5 4828.7 4837.7 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - PROCESS | 19041 | [#1] ext.html Cycles:180 Average:48311.89 Median:188412.83 stddev:90642.76 (48.1%) stddev-sans-first:90826.19 00:29:30 INFO - PROCESS | 19041 | Values: 578.4 584.0 589.5 592.1 593.7 27590.3 29959.7 39483.4 40682.4 41001.4 42022.0 42268.8 42348.4 42351.0 42419.6 7637.9 7836.9 7842.1 7847.0 7853.7 7513.8 9932.0 10225.2 10237.2 10653.4 10327.7 10402.9 10419.2 10423.2 10436.9 7505.1 9966.5 10202.5 10278.6 10279.5 9791.4 10103.2 10118.2 10119.5 10119.5 38373.2 38652.0 38726.4 38764.6 38860.0 3065.5 3196.8 3233.1 3330.7 3622.2 29608.4 29705.0 30241.8 30351.5 31286.5 3440.0 3455.5 3469.9 3480.9 3543.5 253960.0 254492.0 254761.0 254839.7 255312.0 28739.9 29564.3 53005.0 54391.0 54409.5 32354.9 32429.0 32461.4 32516.8 32547.0 14077.2 14285.6 14294.1 14294.9 14296.6 10489.9 11119.6 11470.2 11644.8 11814.9 7868.3 7966.1 7994.9 8008.5 8040.4 3084.3 3112.7 3116.5 3143.7 3182.0 855.5 906.9 911.7 931.0 975.2 28252.9 28260.3 28444.3 28947.6 29038.1 934.1 978.5 1007.8 1029.1 1037.6 15138.5 15139.7 15235.5 15362.6 15367.7 408024.0 411038.8 411287.0 412986.0 413595.0 50027.0 51083.2 51188.2 51197.7 51325.5 1065.2 1113.3 1129.3 1190.3 1197.9 19451.6 31639.0 32051.5 32193.0 32222.4 47763.8 48123.5 48240.3 48262.8 48345.5 343332.0 345647.0 346004.0 346188.0 346394.0 25300.9 25330.0 26279.6 26298.7 26321.0 42132.6 42665.4 43307.4 43557.0 44260.3 36823.3 37121.4 37307.4 37381.6 37675.0 35496.0 36453.0 36794.6 37026.0 37197.3 35221.5 35834.1 36141.0 36308.5 36386.5 31537.5 32774.8 33131.0 33145.8 33493.7 25161.5 25215.5 25219.9 25494.7 25649.5 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - PROCESS | 19041 | [#2] jquery.html Cycles:180 Average:26848.65 Median:211237.67 stddev:70491.67 (33.4%) stddev-sans-first:70661.34 00:29:30 INFO - PROCESS | 19041 | Values: 350.4 368.9 370.1 377.6 396.3 12923.8 17293.2 17554.9 18844.7 19608.1 16983.6 17061.0 17168.0 17250.6 17586.6 5014.2 5409.8 5413.9 5418.9 5419.2 3798.7 5247.3 5965.0 6280.9 6293.9 6103.8 6322.4 6356.2 6361.3 6367.7 6323.5 6345.7 6349.6 6356.8 6397.6 5345.7 5509.9 5510.5 5512.0 5564.8 21031.5 21241.7 21473.8 21769.1 21835.8 1973.4 2192.7 2521.3 2545.0 2613.2 13371.3 14199.5 14428.6 14909.6 15063.4 1869.2 1912.2 1952.3 1963.6 1988.8 77096.0 82770.0 83101.6 83560.6 83778.6 14258.5 14868.7 16563.0 16640.7 16944.2 28790.9 29119.9 29136.4 29238.3 29255.0 9131.5 9154.6 9216.9 9333.8 9378.0 7358.6 7453.9 7502.5 7707.2 7763.4 8434.4 8548.7 8652.7 8672.0 8676.4 3310.2 3331.6 3394.8 3409.8 3415.6 772.5 839.3 850.3 869.7 929.3 16428.9 17034.0 17042.4 17472.9 17559.6 829.2 843.0 899.1 909.3 931.1 9374.3 9467.9 9513.8 9571.8 9745.0 422079.0 427852.0 428460.0 428752.0 431430.0 77940.0 79321.0 79845.0 80530.2 80788.6 970.4 988.3 995.2 997.0 1000.6 11946.0 15132.6 16378.9 16485.6 16702.5 38222.0 38348.4 38848.8 38932.2 39483.4 44179.3 44985.1 47573.3 48388.5 49193.3 4966.0 6608.7 7683.1 7875.0 8233.6 8623.1 11796.4 12044.8 12226.3 12267.3 10359.7 10475.4 10537.9 10605.0 10734.6 10396.9 10545.3 10579.5 10842.6 10877.3 10694.3 10728.7 10736.7 10950.4 11055.9 7828.3 7890.8 7914.8 7916.0 8075.7 10394.8 10554.4 10626.0 10762.6 10764.5 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - PROCESS | 19041 | [#3] mootools.html Cycles:180 Average:5182.57 Median:5704.54 stddev:2851.29 (50.0%) stddev-sans-first:2844.90 00:29:30 INFO - PROCESS | 19041 | Values: 1369.8 1423.6 1481.7 1695.9 1698.9 7342.8 7801.7 7870.2 7874.1 7874.3 6567.3 7376.0 7595.5 7603.2 7734.8 2171.0 2189.1 2195.2 2197.1 2201.3 2153.7 2169.3 2209.6 2210.0 2211.6 1846.7 2090.7 2157.3 2165.5 2192.5 2167.7 2170.0 2177.1 2192.1 2196.2 2194.1 2200.6 2205.4 2206.4 2206.9 7912.3 7970.2 7978.4 7983.3 7984.3 4489.0 4591.4 4599.4 4700.4 4758.2 2763.9 2803.1 2927.0 2944.1 2948.1 896.6 916.5 924.8 933.6 935.6 10326.9 10398.8 10407.8 10453.6 10487.2 4034.3 4108.1 4280.4 4284.8 4312.4 8943.2 8992.7 8993.8 8999.1 9007.9 4684.3 4689.9 4693.6 4695.1 4695.5 4140.4 4247.5 4275.5 4280.2 4283.4 3672.3 3731.7 3753.1 3820.7 3826.3 1087.9 1206.4 1206.9 1213.2 1213.2 665.8 810.2 856.9 873.8 878.7 5361.2 5626.7 5660.3 5753.8 5838.2 837.5 842.7 858.3 890.4 894.3 3703.0 3709.3 3739.0 3750.8 3859.6 9376.8 9673.5 9694.5 9748.6 9755.8 8188.5 9031.1 9677.4 9700.4 9710.5 7102.6 7391.9 7469.0 7471.3 7496.2 5585.6 5621.7 5689.6 5719.5 5721.7 8870.6 9026.2 9026.8 9029.6 9043.9 8707.8 9017.0 9257.0 9260.2 9262.8 6550.1 6587.2 6606.0 6661.5 6676.6 7510.8 7532.4 7537.6 7586.2 7587.6 6652.2 6793.7 6873.9 6961.8 7008.3 6850.8 6864.7 6865.5 6935.8 6949.4 6351.4 6382.4 6423.5 6444.0 6448.4 4675.9 4793.2 4857.0 4911.5 4927.2 4791.7 4817.5 4865.4 4886.6 4960.1 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - PROCESS | 19041 | [#4] prototype.html Cycles:180 Average:4196.40 Median:4821.08 stddev:1217.70 (25.3%) stddev-sans-first:1185.50 00:29:30 INFO - PROCESS | 19041 | Values: 301.1 302.5 305.6 308.4 311.5 4823.8 4838.8 4847.9 4855.5 4863.6 4792.1 4792.1 4793.4 4813.3 4818.4 3599.9 3682.9 3694.9 3772.4 3819.2 3773.8 3775.3 3792.5 3803.4 3830.0 3603.9 3745.5 3759.2 3787.9 3789.7 3648.2 3742.6 3767.0 3767.5 3779.8 3302.2 3319.5 3324.7 3328.4 3341.4 4687.1 4694.7 4700.2 4707.5 4724.6 4197.9 4251.2 4310.2 4312.9 4322.9 4987.7 5037.8 5041.0 5048.7 5054.3 3620.6 3647.9 3658.1 3662.1 3668.9 4997.4 5228.0 5273.4 5273.8 5299.2 3645.2 3652.2 3655.9 3664.9 3680.7 3705.9 3713.5 3716.4 3720.4 3722.6 4280.7 4281.3 4288.7 4301.5 4311.6 4846.4 5029.7 5039.8 5040.8 5130.6 1284.6 1289.6 1289.7 1291.7 1292.2 828.4 831.0 840.7 847.2 850.9 4340.2 4346.6 4486.6 4501.3 4505.5 5191.9 5198.4 5215.5 5219.9 5235.5 4291.5 4460.9 4467.6 4469.7 4526.2 2770.3 2770.3 2774.8 2782.8 2783.6 4922.6 4934.6 4937.6 4937.9 4945.9 5215.3 5318.5 5319.7 5342.6 5355.5 4872.3 4883.9 4892.8 4909.6 4920.4 5190.9 5198.3 5225.6 5235.3 5239.7 4931.1 5073.4 5098.7 5123.1 5148.8 4864.0 4872.1 4876.6 4881.6 4891.5 3654.9 3688.8 3691.3 3700.9 3722.8 4976.6 5120.7 5176.2 5209.1 5215.6 4996.7 5002.5 5027.6 5036.5 5077.3 5053.5 5073.4 5074.3 5085.4 5095.1 4691.2 4974.6 4986.0 5020.7 5045.8 4829.5 4953.9 5107.5 5130.5 5145.7 5000.6 5000.6 5018.2 5026.8 5039.7 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - PROCESS | 19041 | [#5] yui.html Cycles:180 Average:17370.97 Median:23107.38 stddev:23927.46 (103.5%) stddev-sans-first:23961.71 00:29:30 INFO - PROCESS | 19041 | Values: 667.8 681.4 682.8 722.8 734.7 12275.7 13224.2 13233.9 13248.0 13261.4 13010.2 13094.7 13127.3 13186.6 13192.0 605.0 615.6 741.3 757.4 764.2 740.3 766.6 768.3 769.6 774.2 799.8 815.4 818.7 818.8 819.0 642.9 754.3 758.3 771.1 774.0 572.7 572.8 574.0 574.2 574.5 11999.6 12047.0 12049.8 12050.2 12063.6 12236.3 12576.1 12746.0 12838.9 12929.5 11451.4 11851.9 12065.8 12205.9 12619.8 4045.8 4112.2 4131.3 4131.8 4177.2 60456.7 60526.4 60764.7 61326.0 61470.0 9630.9 9811.8 9994.3 10306.9 10316.5 17311.2 17509.7 17516.3 17533.4 17587.7 6847.3 6857.3 6938.8 6969.5 7030.6 3484.2 3591.2 3636.6 3673.1 3732.1 2770.9 2856.1 2865.5 2867.5 2867.7 472.5 477.8 479.6 495.4 501.1 568.5 581.3 591.1 596.6 610.1 8464.8 8525.5 8530.5 8702.4 8758.7 572.0 582.9 591.8 602.2 631.8 4076.8 4092.4 4106.3 4212.7 4290.7 77816.6 81618.2 82032.0 96731.5 103900.0 70354.3 71192.6 71592.6 80929.2 83387.2 73262.3 75046.0 75962.2 76756.0 76840.2 8670.3 8846.3 8886.1 8950.8 9211.4 38950.7 39422.2 41253.0 43332.4 45742.3 61938.4 63031.4 63580.7 64701.4 65401.0 11319.1 11769.2 11867.7 11888.3 12330.0 13379.0 13397.6 13623.2 13628.7 13632.8 11483.7 11607.2 12334.3 13200.2 13699.5 12456.8 12626.4 12672.9 12684.2 13237.6 11963.2 12108.2 12126.1 12621.0 12650.2 9901.2 9911.8 10430.8 10675.6 10806.4 10312.2 10608.8 10758.1 10912.3 11027.3 00:29:30 INFO - PROCESS | 19041 | -------- Summary: end -------- 00:29:30 INFO - PROCESS | 19041 | 00:29:30 INFO - TEST-INFO | 19041: exit 0 00:29:30 INFO - TEST-OK | dromaeo_css | took 1119118ms 00:29:30 INFO - TEST-START | kraken 00:29:30 INFO - operating with platform_type : linux_ 00:29:30 INFO - Initialising browser for kraken test... 00:29:30 INFO - TEST-INFO | started process 19233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVg39cP/profile http://localhost:48038/getInfo.html) 00:29:35 INFO - PROCESS | 19233 | __metrics Screen width/height:1600/1200 00:29:35 INFO - PROCESS | 19233 | colorDepth:24 00:29:35 INFO - PROCESS | 19233 | Browser inner width/height: 1024/697 00:29:35 INFO - PROCESS | 19233 | __metrics 00:29:35 INFO - PROCESS | 19233 | 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" 00:29:35 INFO - PROCESS | 19233 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:29:36 INFO - TEST-INFO | 19233: exit 0 00:29:36 INFO - Browser initialized. 00:29:36 INFO - Running cycle 1/1 for kraken test... 00:29:36 INFO - TEST-INFO | started process 19314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVg39cP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:29:48 INFO - PROCESS | 19314 | RSS: Main: 158715904 00:29:48 INFO - PROCESS | 19314 | 00:29:51 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48038/tests/kraken/driver.html?testName=audio-beat-detection) 00:29:52 INFO - PROCESS | 19314 | RSS: Main: 218259456 00:29:52 INFO - PROCESS | 19314 | 00:29:55 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48038/tests/kraken/driver.html?testName=audio-dft) 00:29:55 INFO - PROCESS | 19314 | RSS: Main: 204591104 00:29:55 INFO - PROCESS | 19314 | 00:29:59 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48038/tests/kraken/driver.html?testName=audio-fft) 00:29:59 INFO - PROCESS | 19314 | RSS: Main: 272617472 00:29:59 INFO - PROCESS | 19314 | 00:30:01 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48038/tests/kraken/driver.html?testName=audio-oscillator) 00:30:02 INFO - PROCESS | 19314 | RSS: Main: 181608448 00:30:02 INFO - PROCESS | 19314 | 00:30:04 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:30:05 INFO - PROCESS | 19314 | RSS: Main: 186310656 00:30:05 INFO - PROCESS | 19314 | 00:30:08 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48038/tests/kraken/driver.html?testName=imaging-darkroom) 00:30:08 INFO - PROCESS | 19314 | RSS: Main: 222138368 00:30:08 INFO - PROCESS | 19314 | 00:30:12 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48038/tests/kraken/driver.html?testName=imaging-desaturate) 00:30:13 INFO - PROCESS | 19314 | RSS: Main: 218112000 00:30:13 INFO - PROCESS | 19314 | 00:30:16 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48038/tests/kraken/driver.html?testName=json-parse-financial) 00:30:16 INFO - PROCESS | 19314 | RSS: Main: 220602368 00:30:16 INFO - PROCESS | 19314 | 00:30:18 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:30:18 INFO - PROCESS | 19314 | RSS: Main: 209887232 00:30:18 INFO - PROCESS | 19314 | 00:30:20 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:30:21 INFO - PROCESS | 19314 | RSS: Main: 213389312 00:30:21 INFO - PROCESS | 19314 | 00:30:23 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:30:24 INFO - PROCESS | 19314 | RSS: Main: 209764352 00:30:24 INFO - PROCESS | 19314 | 00:30:27 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:30:27 INFO - PROCESS | 19314 | RSS: Main: 224165888 00:30:27 INFO - PROCESS | 19314 | 00:30:30 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:30:31 INFO - PROCESS | 19314 | RSS: Main: 224780288 00:30:31 INFO - PROCESS | 19314 | 00:30:32 INFO - PROCESS | 19314 | Cycle 1(1): loaded http://localhost:48038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48038/tests/kraken/driver.html?testName=ai-astar) 00:30:33 INFO - PROCESS | 19314 | RSS: Main: 267288576 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | __start_tp_report 00:30:33 INFO - PROCESS | 19314 | _x_x_mozilla_page_load 00:30:33 INFO - PROCESS | 19314 | _x_x_mozilla_page_load_details 00:30:33 INFO - PROCESS | 19314 | |i|pagename|runs| 00:30:33 INFO - PROCESS | 19314 | |0;ai-astar;104;115;113;114;113;115;113;114;114;114 00:30:33 INFO - PROCESS | 19314 | |1;audio-beat-detection;145;121;127;172;129;127;147;126;164;125 00:30:33 INFO - PROCESS | 19314 | |2;audio-dft;161;161;160;161;160;162;161;162;160;160 00:30:33 INFO - PROCESS | 19314 | |3;audio-fft;74;76;76;105;75;76;76;75;101;76 00:30:33 INFO - PROCESS | 19314 | |4;audio-oscillator;84;85;117;85;84;85;118;85;84;129 00:30:33 INFO - PROCESS | 19314 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 00:30:33 INFO - PROCESS | 19314 | |6;imaging-darkroom;147;146;146;146;146;145;146;146;146;146 00:30:33 INFO - PROCESS | 19314 | |7;imaging-desaturate;95;95;95;95;95;94;94;94;95;100 00:30:33 INFO - PROCESS | 19314 | |8;json-parse-financial;64;64;65;64;66;64;66;63;63;62 00:30:33 INFO - PROCESS | 19314 | |9;json-stringify-tinderbox;66;66;65;65;66;64;65;65;74;66 00:30:33 INFO - PROCESS | 19314 | |10;stanford-crypto-aes;85;79;79;80;78;79;78;78;77;84 00:30:33 INFO - PROCESS | 19314 | |11;stanford-crypto-ccm;130;137;133;139;131;128;126;134;169;130 00:30:33 INFO - PROCESS | 19314 | |12;stanford-crypto-pbkdf2;167;177;173;164;164;165;163;167;164;163 00:30:33 INFO - PROCESS | 19314 | |13;stanford-crypto-sha256-iterative;66;68;67;66;69;65;66;65;67;65 00:30:33 INFO - PROCESS | 19314 | __end_tp_report 00:30:33 INFO - PROCESS | 19314 | __start_cc_report 00:30:33 INFO - PROCESS | 19314 | _x_x_mozilla_cycle_collect,1912 00:30:33 INFO - PROCESS | 19314 | __end_cc_report 00:30:33 INFO - PROCESS | 19314 | __startTimestamp1468999833088__endTimestamp 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | ------- Summary: start ------- 00:30:33 INFO - PROCESS | 19314 | Number of tests: 14 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.21 (2.8%) stddev-sans-first:0.78 00:30:33 INFO - PROCESS | 19314 | Values: 104.0 115.0 113.0 114.0 113.0 115.0 113.0 114.0 114.0 114.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:137.00 stddev:17.91 (13.1%) stddev-sans-first:18.83 00:30:33 INFO - PROCESS | 19314 | Values: 145.0 121.0 127.0 172.0 129.0 127.0 147.0 126.0 164.0 125.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 00:30:33 INFO - PROCESS | 19314 | Values: 161.0 161.0 160.0 161.0 160.0 162.0 161.0 162.0 160.0 160.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.65 (15.3%) stddev-sans-first:12.08 00:30:33 INFO - PROCESS | 19314 | Values: 74.0 76.0 76.0 105.0 75.0 76.0 76.0 75.0 101.0 76.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.50 stddev:18.04 (21.3%) stddev-sans-first:18.64 00:30:33 INFO - PROCESS | 19314 | Values: 84.0 85.0 117.0 85.0 84.0 85.0 118.0 85.0 84.0 129.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 00:30:33 INFO - PROCESS | 19314 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 00:30:33 INFO - PROCESS | 19314 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.75 (1.8%) stddev-sans-first:1.86 00:30:33 INFO - PROCESS | 19314 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 100.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 00:30:33 INFO - PROCESS | 19314 | Values: 64.0 64.0 65.0 64.0 66.0 64.0 66.0 63.0 63.0 62.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:2.82 (4.3%) stddev-sans-first:2.99 00:30:33 INFO - PROCESS | 19314 | Values: 66.0 66.0 65.0 65.0 66.0 64.0 65.0 65.0 74.0 66.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:2.67 (3.4%) stddev-sans-first:2.03 00:30:33 INFO - PROCESS | 19314 | Values: 85.0 79.0 79.0 80.0 78.0 79.0 78.0 78.0 77.0 84.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:133.50 stddev:12.35 (9.2%) stddev-sans-first:12.92 00:30:33 INFO - PROCESS | 19314 | Values: 130.0 137.0 133.0 139.0 131.0 128.0 126.0 134.0 169.0 130.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:166.00 stddev:4.69 (2.8%) stddev-sans-first:4.97 00:30:33 INFO - PROCESS | 19314 | Values: 167.0 177.0 173.0 164.0 164.0 165.0 163.0 167.0 164.0 163.0 00:30:33 INFO - PROCESS | 19314 | 00:30:33 INFO - PROCESS | 19314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 00:30:33 INFO - PROCESS | 19314 | Values: 66.0 68.0 67.0 66.0 69.0 65.0 66.0 65.0 67.0 65.0 00:30:33 INFO - PROCESS | 19314 | -------- Summary: end -------- 00:30:33 INFO - PROCESS | 19314 | 00:30:34 INFO - TEST-INFO | 19314: exit 0 00:30:34 INFO - TEST-OK | kraken | took 63392ms 00:30:34 INFO - SUITE-END | took 1182s 00:30:34 INFO - Completed test suite (00:19:42) 00:30:34 INFO - javascript benchmark 00:30:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.648507451494, 2618.1883616079003, 2647.02060237712, 2652.615370771237, 2658.853763043032, 4600.217962946299, 4644.164050470914, 4665.4168228971375, 4703.6472264580125, 4712.552307530784, 4703.341532185488, 4726.550977657117, 4738.123447162277, 4755.952440475594, 4769.0, 4126.401671757593, 4293.720908140968, 4380.08018316154, 4407.779611019452, 4491.573300536444, 4402.669799765014, 4431.180231657154, 4450.154470650566, 4454.754988475633, 4472.776361181945, 4218.810153543098, 4245.936310955338, 4297.935530967006, 4301.2902871026245, 4370.147821174856, 4270.935935960932, 4306.181825453154, 4320.740755554645, 4356.499002614708, 4379.0, 4330.501992270866, 4337.414449049369, 4350.912981740347, 4382.8904277393, 4393.824247030115, 4567.177907976563, 4686.297055441677, 4746.240601503743, 4752.049590081998, 4762.9523704763205, 5014.674046186986, 5105.361829771278, 5111.08000559899, 5158.97420512895, 5193.532582067632, 5109.514596113363, 5139.84580462583, 5140.177571588528, 5149.613778966593, 5162.354705661793, 4560.270356742905, 4613.123506533748, 4763.380760501147, 4775.856724298276, 4791.880202994883, 5053.974730126326, 5126.282320475062, 5133.743312834418, 5137.691738495702, 5143.048536020848, 4887.193613053877, 4891.804327826918, 4892.0, 4938.851834444972, 4942.481039490874, 4948.876278093005, 4961.603071754251, 5003.5997120230295, 5012.122878496249, 5014.448410674823, 4996.175631020841, 5043.5460808527405, 5049.495050494921, 5055.545000949932, 5059.443461219263, 5016.423111342169, 5028.874278143076, 5030.496950304941, 5058.620603454756, 5071.87320316995, 4228.5982831630945, 4263.083437061046, 4386.342048692722, 4403.603675669206, 4440.000999775025, 3746.194568167857, 3794.5636251830842, 3796.4115562087923, 3815.027168072124, 3824.388097904322, 4362.258416069276, 4381.78091095444, 4385.846495372647, 4388.29787234041, 4434.17967675981, 4872.220444728897, 4918.163912134945, 5110.8466745997675, 5110.948890511122, 5148.0476111919415, 4295.806688699016, 4325.545817689161, 4332.025294308755, 4350.760708161081, 4353.412289340962, 4583.037562111927, 4584.243599805995, 4599.0, 4609.608183304456, 4624.28323609841, 4665.2535594304745, 4708.670393072452, 4738.5261473853025, 4745.572898439157, 4754.952450475451, 5029.9245511318095, 5054.090263752413, 5078.619103567321, 5122.026814905156, 5143.871403214949, 4773.594244489257, 4790.808367665394, 4791.784369703302, 4809.831655892027, 4856.78144483492, 4967.05625931072, 5013.899722005613, 5014.774335154853, 5023.196288593954, 5077.365329333833, 4964.304997300309, 5000.824971126139, 5002.0, 5049.2930989660745, 5066.468020857904, 4901.607871370353, 4906.484819094087, 4929.309896614549, 4930.334404855299, 4983.800647974185, 4829.203181475017, 4951.9752401237765, 4974.825881094144, 4977.651564390458, 5021.020900924431, 4835.879103022312, 4875.8049678012485, 4878.0975519529, 4879.73161476108, 4880.097182021337, 4938.08645400602, 4941.382327209099, 4945.505449455026, 4946.802127914843, 4997.300377947017, 4728.3380326753595, 4779.761011949319, 4818.518148185153, 4828.66199366041, 4837.685550439211], "value": 4642.006657574821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.436024875746, 583.9941600583993, 589.4930359890493, 592.0852283222421, 593.6883136353414, 27590.31024224393, 29959.700402995964, 39483.40774888376, 40682.389764153486, 41001.38497922534, 42022.0, 42268.78865605676, 42348.3647745284, 42351.0, 42419.57580424195, 7637.885431718529, 7836.882446763303, 7842.098158711764, 7846.960765196166, 7853.725119620814, 7513.849723005536, 9931.950340248324, 10225.23310751693, 10237.18102551794, 10653.360798352085, 10327.690169294896, 10402.895971040307, 10419.218558608096, 10423.166146708245, 10436.895631043706, 7505.136909255396, 9966.501674916297, 10202.540885660126, 10278.640247591373, 10279.537420816081, 9791.412515249107, 10103.242256830767, 10118.241131915136, 10119.544620492023, 10119.544620492095, 38373.232535349416, 38652.033699157466, 38726.419103713466, 38764.612353876386, 38860.0, 3065.5401689746495, 3196.824174670392, 3233.094733474631, 3330.7002369786837, 3622.2031153146268, 29608.407831843244, 29705.0, 30241.848790756125, 30351.544726829114, 31286.530702039487, 3440.0195944155794, 3455.51622772812, 3469.9132521686906, 3480.930381392358, 3543.539339885824, 253960.0, 254492.0, 254761.0, 254839.72580137165, 255312.0, 28739.856300718362, 29564.260893477403, 53005.0, 54391.0, 54409.45590544123, 32354.926282003173, 32429.0, 32461.35077298488, 32516.83741581277, 32547.0, 14077.225752583707, 14285.57143285703, 14294.142351458946, 14294.927880409012, 14296.642583935485, 10489.947550262352, 11119.610813621484, 11470.197086203885, 11644.76710465786, 11814.88185118155, 7868.25251601097, 7966.123726390092, 7994.880076798852, 8008.479448835807, 8040.396970227256, 3084.306031142975, 3112.7042930921525, 3116.4857798463, 3143.701348371901, 3181.984090079535, 855.5465603230298, 906.9047749986288, 911.7310393433953, 930.9767255818658, 975.190591808797, 28252.85873570619, 28260.315270049312, 28444.288892777433, 28947.56578651322, 29038.12885613435, 934.1452570897688, 978.5107446276861, 1007.808516381885, 1029.1098200056897, 1037.6368271105205, 15138.470153544793, 15139.697206055816, 15235.466758663615, 15362.615318920885, 15367.692646147014, 408024.0, 411038.834417484, 411287.0, 412986.0, 413595.0, 50027.0, 51083.23375149376, 51188.232176517384, 51197.744011279705, 51325.48674513207, 1065.2170654568886, 1113.3264375052977, 1129.271619805221, 1190.2798806721808, 1197.8562572491358, 19451.638385312894, 31639.0, 32051.519227211145, 32193.0, 32222.35555288834, 47763.76118119526, 48123.5187648119, 48240.276395854795, 48262.75868620635, 48345.51654483551, 343332.0, 345647.0, 346004.0, 346188.0, 346394.0, 25300.92211222099, 25330.0, 26279.60580591331, 26298.73701262963, 26321.0, 42132.57867421286, 42665.36001959911, 43307.35038974355, 43557.0, 44260.336094959246, 36823.26353472969, 37121.44317835181, 37307.44038839474, 37381.6261837389, 37675.0, 35496.0, 36453.0, 36794.63205367912, 37026.0, 37197.25605487929, 35221.47167792434, 35834.10414739652, 36141.0, 36308.455373168894, 36386.45420318644, 31537.52693709642, 32774.82672636439, 33131.0, 33145.83427082849, 33493.66506335003, 25161.496770064863, 25215.495690086464, 25219.87390063038, 25494.74505254998, 25649.487010259316], "value": 17172.86248111945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3623405402169, 368.8524590163934, 370.13204036534324, 377.61294672960213, 396.33020195868977, 12923.806142907852, 17293.221805018773, 17554.91222543887, 18844.717329240073, 19608.117634706436, 16983.57541061474, 17061.0, 17168.0, 17250.568735781613, 17586.648267034652, 5014.1726615108555, 5409.783608655649, 5413.891722165555, 5418.891622167574, 5419.214213938976, 3798.7150963677695, 5247.291615631898, 5964.970175149118, 6280.937190628104, 6293.9370606293805, 6103.755849766004, 6322.39937205967, 6356.173697419329, 6361.300256971729, 6367.745290188387, 6323.462505687022, 6345.682715864212, 6349.619022858597, 6356.77751278703, 6397.616143031387, 5345.732713364355, 5509.944900550983, 5510.504054635102, 5511.9724401378135, 5564.8052318169075, 21031.47421314464, 21241.68137477939, 21473.785262147492, 21769.129234830587, 21835.781642183534, 1973.4178417366911, 2192.6601376786466, 2521.2814347910758, 2545.0, 2613.163787587973, 13371.331433428388, 14199.503017394341, 14428.639284017983, 14909.627259318495, 15063.397464101423, 1869.242956602578, 1912.1682068300333, 1952.326447375653, 1963.5974625201943, 1988.8210061094571, 77096.0, 82770.0, 83101.58449207715, 83560.58219708863, 83778.58110709468, 14258.500952466615, 14868.70262594742, 16563.0, 16640.6671866562, 16944.23750931211, 28790.856045719636, 29119.854400728284, 29136.41727165445, 29238.269043273664, 29255.0, 9131.452112873249, 9154.633814647472, 9216.861747073799, 9333.82649899024, 9377.953110234404, 7358.595277259802, 7453.925460745323, 7502.4748267621835, 7707.152213256537, 7763.378929685611, 8434.409591328547, 8548.700795472128, 8652.697155599524, 8671.956640216884, 8676.392652514263, 3310.155910242873, 3331.6168640606156, 3394.8273105212684, 3409.8124603147066, 3415.6072051713872, 772.4901564967095, 839.2907992746242, 850.3112478891993, 869.699953516036, 929.3355250995571, 16428.917855410647, 17034.0, 17042.403515876886, 17472.912635436995, 17559.648807023787, 829.2453866981018, 842.9620667069996, 899.1098812175899, 909.2907532124954, 931.0735817861272, 9374.343795934356, 9467.905320946702, 9513.809723805485, 9571.808563828685, 9745.0, 422079.0, 427852.0, 428460.0, 428752.0, 431430.0, 77940.0, 79321.0, 79845.0, 80530.19469805344, 80788.59605701934, 970.4419958523877, 988.2933702402817, 995.2436148527026, 996.960121595128, 1000.6097621927308, 11946.0, 15132.638760741467, 16378.918105409874, 16485.58786030359, 16702.49892503227, 38222.0, 38348.424773628976, 38848.805755971036, 38932.22135557216, 39483.40774888321, 44179.33730994102, 44985.1002979932, 47573.28640070471, 48388.51611483981, 49193.2621010678, 4965.975170124127, 6608.7026083825385, 7683.116441609286, 7874.960625196837, 8233.629486672995, 8623.142979392409, 11796.351200684045, 12044.75910481803, 12226.327551984727, 12267.325297108744, 10359.689209323733, 10475.371477711362, 10537.947310263706, 10605.045545900906, 10734.624288149877, 10396.948015259875, 10545.261831671709, 10579.523921423708, 10842.620508282173, 10877.292975956538, 10694.25140240207, 10728.678139655824, 10736.73158171052, 10950.39772812503, 11055.944720276348, 7828.334591559781, 7890.802729931797, 7914.841703166019, 7916.0, 8075.676972921017, 10394.792104157723, 10554.419506927192, 10626.0, 10762.63616720793, 10764.461776910966], "value": 9303.905339325414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.8013788000744, 1423.615623781579, 1481.6814384907243, 1695.9067251301174, 1698.8980661160324, 7342.779716608504, 7801.726939557117, 7870.173631768661, 7874.055113386402, 7874.330681892046, 6567.34326567343, 7376.0, 7595.468317217783, 7603.201663825302, 7734.8453030939345, 2170.9565808683856, 2189.0805861538192, 2195.1877805212093, 2197.055266235518, 2201.306588424649, 2153.655415133579, 2169.2624507667388, 2209.6133176694093, 2210.0165426385265, 2211.557688462306, 1846.704527275636, 2090.6550419180817, 2157.255746767363, 2165.4586353411646, 2192.5176461178517, 2167.6640120781303, 2170.0, 2177.1291483406685, 2192.1341070277153, 2196.2203417786777, 2194.089452877054, 2200.559888022402, 2205.38249290199, 2206.393241858486, 2206.911723531057, 7912.327452166573, 7970.163132871081, 7978.441509094366, 7983.28150466455, 7984.281414672707, 4488.955110448886, 4591.3572099905705, 4599.425071866017, 4700.388949436586, 4758.167320718895, 2763.9447211055667, 2803.1170181392795, 2926.956095658567, 2944.0873329267997, 2948.0713575223735, 896.6099746610246, 916.509667327983, 924.7734305095295, 933.5752232734089, 935.5696379665362, 10326.948365258126, 10398.844017339747, 10407.843882341771, 10453.581856725721, 10487.213458990605, 4034.2738307104414, 4108.055147316074, 4280.422143010716, 4284.807183676742, 4312.439382880206, 8943.195112439911, 8992.730218093468, 8993.820123597623, 8999.145081217273, 9007.909920900838, 4684.250519916797, 4689.929651055237, 4693.601043911238, 4695.131400690883, 4695.460022097434, 4140.420341152241, 4247.532771395144, 4275.46556680415, 4280.16536775332, 4283.378910058086, 3672.3022625701033, 3731.7014638828828, 3753.1367785409507, 3820.7134464915243, 3826.292135954802, 1087.8857719939451, 1206.4390058622782, 1206.877603828448, 1213.2114125818111, 1213.2174747288127, 665.7603262825379, 810.2383759266271, 856.9014563325172, 873.8121303919688, 878.7188099808, 5361.249425080492, 5626.718664066781, 5660.349059858087, 5753.798617048467, 5838.241028666331, 837.539353355652, 842.6629348260623, 858.2576071697937, 890.3811850763657, 894.2532984957634, 3702.9629703702617, 3709.3137769512186, 3738.981305093457, 3750.849966001384, 3859.575446700917, 9376.812463750686, 9673.467959262309, 9694.5152742364, 9748.561314740853, 9755.804883902283, 8188.50868947865, 9031.142041506046, 9677.37097088687, 9700.369475984038, 9710.514474276259, 7102.573845569283, 7391.926080739231, 7469.0, 7471.327580517779, 7496.175420703718, 5585.636933599303, 5621.747021383966, 5689.601727879009, 5719.48524632785, 5721.713914304185, 8870.645174193218, 9026.232770214605, 9026.81946361056, 9029.593668284811, 9043.864342035007, 8707.825843482968, 9016.954915225644, 9257.0, 9260.212881905114, 9262.814743705223, 6550.148480697479, 6587.209534855656, 6606.0, 6661.500387471056, 6676.566023208476, 7510.812229694083, 7532.359749421142, 7537.585432801248, 7586.165521792709, 7587.62061896914, 6652.201735791542, 6793.72825086991, 6873.931260687329, 6961.756338528127, 7008.264132266243, 6850.8287292816085, 6864.725410983505, 6865.450763938773, 6935.826604334932, 6949.409300209539, 6351.428371446407, 6382.3617638237665, 6423.486121110206, 6444.0, 6448.419642232222, 4675.883102922454, 4793.209120495079, 4857.028594281087, 4911.50884911506, 4927.236278376714, 4791.736454494897, 4817.470078291315, 4865.440474345495, 4886.560209581155, 4960.131976903956], "value": 4183.0427381745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.0696946435514, 302.4510513418147, 305.5569424334715, 308.4032397311203, 311.53114562583306, 4823.78292976816, 4838.782254798538, 4847.878803029926, 4855.538723821236, 4863.635227357945, 4792.113459010076, 4792.137415265251, 4793.4487533933525, 4813.253945638423, 4818.373611430509, 3599.892003239907, 3682.926341473169, 3694.8891533254045, 3772.396416573335, 3819.19796842662, 3773.792441415721, 3775.2826962876966, 3792.4500947362617, 3803.3914573668217, 3830.0, 3603.9279214415697, 3745.494358261627, 3759.191773768639, 3787.8674246401383, 3789.730440302488, 3648.2338708871034, 3742.58831528533, 3766.9623303766884, 3767.472553842464, 3779.8110094495164, 3302.207470207157, 3319.502074688816, 3324.7007769300635, 3328.3842489139342, 3341.365140623274, 4687.1328804171335, 4694.718316900997, 4700.224462963607, 4707.529247075299, 4724.551167639069, 4197.853075142355, 4251.192273468062, 4310.202612516695, 4312.892177695551, 4322.891927701832, 4987.725675087869, 5037.79848806051, 5040.974795126038, 5048.7223202723835, 5054.292399064134, 3620.565532136134, 3647.854085836563, 3658.0854786303425, 3662.1393972416463, 3668.853245870189, 4997.42529609096, 5228.0, 5273.446288139767, 5273.815416460444, 5299.1786273127345, 3645.234500754871, 3652.160003199226, 3655.8903232903053, 3664.8900532984053, 3680.6871415929945, 3705.9073523161596, 3713.4801127842125, 3716.3682174030478, 3720.4233343831747, 3722.590515043343, 4280.657547396201, 4281.250781113293, 4288.7212331199, 4301.462317210348, 4311.590398912098, 4846.36997190363, 5029.673071250357, 5039.77321020555, 5040.79836806531, 5130.563902068291, 1284.6017734502334, 1289.6131160651767, 1289.7098152915519, 1291.6964513339358, 1292.1923797626484, 828.4035494443991, 830.9584520773938, 840.7435732101768, 847.186700767258, 850.8638617821242, 4340.220509591052, 4346.60908509274, 4486.609151163085, 4501.3022981437925, 4505.459344878635, 5191.858925350184, 5198.4007996002, 5215.452377500308, 5219.947800521946, 5235.502627250406, 4291.527931927485, 4460.888477788017, 4467.642588592905, 4469.709468884512, 4526.207913615104, 2770.279727270924, 2770.321271288507, 2774.7502724754463, 2782.819116757404, 2783.6381270435118, 4922.606191504671, 4934.629902757236, 4937.580305674058, 4937.851864444073, 4945.876353091202, 5215.29593504872, 5318.468153184728, 5319.723266416032, 5342.557509472421, 5355.518003379637, 4872.269159626014, 4883.926741098886, 4892.755362231803, 4909.607231421478, 4920.384951881015, 5190.870228244324, 5198.298229739088, 5225.634205605571, 5235.345581802275, 5239.66388570912, 4931.076880016868, 5073.44192138857, 5098.668586541863, 5123.1054454233235, 5148.794048238028, 4863.975680121577, 4872.147374209429, 4876.561414382694, 4881.609471242221, 4891.486393928729, 3654.9269014619026, 3688.7786732796117, 3691.3171063353366, 3700.9444858327684, 3722.81385930697, 4976.601871850171, 5120.74396280177, 5176.171812509981, 5209.140491818807, 5215.5827533797965, 4996.725180115129, 5002.499750024968, 5027.622928280321, 5036.521530454601, 5077.263796749525, 5053.494650534917, 5073.3911930568565, 5074.289599456005, 5085.364329458817, 5095.13382724945, 4691.202495575692, 4974.626902982219, 4985.975070124626, 5020.673656212334, 5045.772940217773, 4829.468758436639, 4953.876153096201, 5107.540321370946, 5130.538251557377, 5145.742712864417, 5000.574951129195, 5000.6249531284575, 5018.197088465828, 5026.84919452417, 5039.748012599429], "value": 3809.783671107361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.8330417395654, 681.3595220492737, 682.7712716240062, 722.8373615936413, 734.7134617499173, 12275.693107672312, 13224.206547607151, 13233.867661323384, 13248.0, 13261.403236854341, 13010.154339967896, 13094.672633184151, 13127.277999710011, 13186.604401867959, 13192.0, 605.0440304319166, 615.6244690738646, 741.3031750154837, 757.3789492616044, 764.2052265643724, 740.2560426771088, 766.6090293950069, 768.320036767462, 769.6228847864562, 774.206438400641, 799.7920540659412, 815.4454970619976, 818.6520728690313, 818.8198596308832, 819.0499021135485, 642.88749468843, 754.3098065270271, 758.29478584916, 771.1363273134069, 774.024728841658, 572.7308165162367, 572.8109723791139, 574.0499473371576, 574.2420005592619, 574.4829653312053, 11999.64001079969, 12047.03623710101, 12049.819252711217, 12050.15648904577, 12063.577774777841, 12236.327002014885, 12576.11967162299, 12746.0, 12838.935805321007, 12929.547465838745, 11451.427428628618, 11851.881481185164, 12065.819012714815, 12205.93897030518, 12619.810702839464, 4045.7977101144825, 4112.239235741367, 4131.29767939448, 4131.752094874317, 4177.248095342868, 60456.69771651114, 60526.39473605251, 60764.696176519275, 61326.0, 61470.0, 9630.903690963141, 9811.75470613226, 9994.300398972002, 10306.948465257627, 10316.48417579118, 17311.220995055253, 17509.7373539397, 17516.29934802619, 17533.386331478338, 17587.73618395725, 6847.281035491302, 6857.27998560144, 6938.826529336807, 6969.54697944632, 7030.578165310098, 3484.216051388468, 3591.2458383739186, 3636.618155093677, 3673.1184515716036, 3732.104294969188, 2770.9030183943464, 2856.11460447262, 2865.5128628133266, 2867.4695181391508, 2867.6702179249237, 472.45195573135, 477.7969363020702, 479.60672248755685, 495.4005653159645, 501.1405439670909, 568.5224411494364, 581.3459857660132, 591.0602142593211, 596.6032588328712, 610.1397030187503, 8464.830703385898, 8525.488470691778, 8530.488170709777, 8702.434341767765, 8758.737237882873, 571.9656820590778, 582.9154772557955, 591.7692100080972, 602.2471910112359, 631.848356394462, 4076.8165432555606, 4092.4475195848777, 4106.342985122366, 4212.68404869636, 4290.678199135077, 77816.61091694505, 81618.18381816224, 82032.0, 96731.51634241783, 103900.0, 70354.2964570358, 71192.64403677949, 71592.64203678949, 80929.19070809217, 83387.17650407151, 73262.26737732661, 75046.0, 75962.24037759552, 76756.0, 76840.23159768443, 8670.271783133314, 8846.33652476054, 8886.11138886132, 8950.820983580423, 9211.447313161232, 38950.690020170856, 39422.21155576815, 41252.96867578335, 43332.35001474917, 45742.313865292715, 61938.38061619326, 63031.36968630439, 63580.68209658922, 64701.35298646953, 65401.0, 11319.103224651322, 11769.17615766888, 11867.703307417383, 11888.28670279786, 12330.0, 13379.0, 13397.598072057854, 13623.18260904349, 13628.727425451238, 13632.795508067586, 11483.655490335303, 11607.187496875138, 12334.321612311409, 13200.20798752078, 13699.520516781864, 12456.81314780261, 12626.431810568363, 12672.936635316764, 12684.175528590613, 13237.602871913858, 11963.171904175482, 12108.21296615717, 12126.090543209471, 12621.0, 12650.240985540897, 9901.207903367856, 9911.752206194902, 10430.843537347098, 10675.626353077605, 10806.35161890289, 10312.226583006155, 10608.840867386842, 10758.11628623389, 10912.290701104721, 11027.338359698444], "value": 6602.861772977014, "unit": "score"}], "name": "dromaeo_css", "value": 6537.296403954539, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 127.0, 172.0, 129.0, 127.0, 147.0, 126.0, 164.0, 125.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 105.0, 75.0, 76.0, 76.0, 75.0, 101.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 85.0, 84.0, 85.0, 118.0, 85.0, 84.0, 129.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 100.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 66.0, 64.0, 66.0, 63.0, 63.0, 62.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 74.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 79.0, 80.0, 78.0, 79.0, 78.0, 78.0, 77.0, 84.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 137.0, 133.0, 139.0, 131.0, 128.0, 126.0, 134.0, 169.0, 130.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 177.0, 173.0, 164.0, 164.0, 165.0, 163.0, 167.0, 164.0, 163.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 69.0, 65.0, 66.0, 65.0, 67.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1525.6000000000004, "alertThreshold": 2.0}]} 00:30:34 INFO - Return code: 0 00:30:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:30:34 INFO - # TBPL SUCCESS # 00:30:34 INFO - Running post-action listener: _resource_record_post_action 00:30:34 INFO - ##### 00:30:34 INFO - ##### Finished run-tests step (success) 00:30:34 INFO - ##### 00:30:34 INFO - Running post-run listener: _resource_record_post_run 00:30:34 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548933632; Read time: 92; Write time: 516972 00:30:34 INFO - TinderboxPrint: CPU usage
13.0% 00:30:34 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 92 00:30:34 INFO - TinderboxPrint: I/O write bytes / time
548,933,632 / 516,972 00:30:34 INFO - TinderboxPrint: CPU idle
8,327.2 (87.0%) 00:30:34 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 00:30:34 INFO - TinderboxPrint: Swap in / out
0 / 0 00:30:34 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 260505600; Read time: 0; Write time: 318652 00:30:34 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 288428032; Read time: 92; Write time: 198320 00:30:35 INFO - Running post-run listener: _upload_blobber_files 00:30:35 INFO - Blob upload gear active. 00:30:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:30:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:30:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:30:35 INFO - (blobuploader) - INFO - Open directory for files ... 00:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:30:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:50 INFO - (blobuploader) - INFO - Done attempting. 00:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:30:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:51 INFO - (blobuploader) - INFO - Done attempting. 00:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:52 INFO - (blobuploader) - INFO - Done attempting. 00:30:52 INFO - (blobuploader) - INFO - Iteration through files over. 00:30:52 INFO - Return code: 0 00:30:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:30:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:30:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d3c6ec51e76043f1f216fd8ba480118ebb570da3b59d9a1a3dc002ad2c6cf120cd732628a1387cf96146ea84923e9f864e693099e7f80ce3fe06ca6cc4e5157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2661f9211f28e5a06a54e38b1a762e638afc118eec608602be1fcd0900c16efc3fea225030b45231e732fa68bcc8a42979927a081f086647a1b1889a05cdcdfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385ab5c124fa6198daf5185dc1016c2d920deb36165c3e1791c6ac0e67ad8f7ca4f24d1960f1202af44638cd1488d7474b245cd7d4f354659a8b6ad764fab875"} 00:30:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:30:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:30:52 INFO - Contents: 00:30:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d3c6ec51e76043f1f216fd8ba480118ebb570da3b59d9a1a3dc002ad2c6cf120cd732628a1387cf96146ea84923e9f864e693099e7f80ce3fe06ca6cc4e5157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2661f9211f28e5a06a54e38b1a762e638afc118eec608602be1fcd0900c16efc3fea225030b45231e732fa68bcc8a42979927a081f086647a1b1889a05cdcdfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385ab5c124fa6198daf5185dc1016c2d920deb36165c3e1791c6ac0e67ad8f7ca4f24d1960f1202af44638cd1488d7474b245cd7d4f354659a8b6ad764fab875"} 00:30:52 INFO - Running post-run listener: copy_logs_to_upload_dir 00:30:52 INFO - Copying logs to upload dir... 00:30:52 INFO - mkdir: /builds/slave/test/build/upload/logs 00:30:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.892017 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-20 00:30:52.312234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 00:30:52.315810) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595 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/9d3c6ec51e76043f1f216fd8ba480118ebb570da3b59d9a1a3dc002ad2c6cf120cd732628a1387cf96146ea84923e9f864e693099e7f80ce3fe06ca6cc4e5157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2661f9211f28e5a06a54e38b1a762e638afc118eec608602be1fcd0900c16efc3fea225030b45231e732fa68bcc8a42979927a081f086647a1b1889a05cdcdfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385ab5c124fa6198daf5185dc1016c2d920deb36165c3e1791c6ac0e67ad8f7ca4f24d1960f1202af44638cd1488d7474b245cd7d4f354659a8b6ad764fab875"} build_url:https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Hli0Y5AnTGihiYI2ewWjew/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/9d3c6ec51e76043f1f216fd8ba480118ebb570da3b59d9a1a3dc002ad2c6cf120cd732628a1387cf96146ea84923e9f864e693099e7f80ce3fe06ca6cc4e5157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2661f9211f28e5a06a54e38b1a762e638afc118eec608602be1fcd0900c16efc3fea225030b45231e732fa68bcc8a42979927a081f086647a1b1889a05cdcdfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385ab5c124fa6198daf5185dc1016c2d920deb36165c3e1791c6ac0e67ad8f7ca4f24d1960f1202af44638cd1488d7474b245cd7d4f354659a8b6ad764fab875"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 00:30:52.341798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:30:52.342177) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468998597.241096-1727134595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 00:30:52.428225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 00:30:52.428579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 00:30:52.428948) ========= ========= Total master_lag: 0.18 =========