builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1467361158.55 results: success (0) buildid: 20160630223048 builduid: 5ae973d5ba3f4eb69efe800ddf7f84d7 revision: 0a03bb6af6043ce323142d24fb43c2d63deefbcb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.549725) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.550285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.550632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.765000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.765315) ========= 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=33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 01:19:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.5M=0s 2016-07-01 01:19:19 (69.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110128 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.894650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.895039) ========= 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=33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017939 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.950714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:18.951323) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a03bb6af6043ce323142d24fb43c2d63deefbcb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a03bb6af6043ce323142d24fb43c2d63deefbcb --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=33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 01:19:19,639 truncating revision to first 12 chars 2016-07-01 01:19:19,639 Setting DEBUG logging. 2016-07-01 01:19:19,639 attempt 1/10 2016-07-01 01:19:19,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0a03bb6af604?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 01:19:19,971 unpacking tar archive at: mozilla-inbound-0a03bb6af604/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:19.681233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:19.681564) ========= script_repo_revision: 0a03bb6af6043ce323142d24fb43c2d63deefbcb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:19.681991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:19.682282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:19:19.695477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-07-01 01:19:19.695762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:19:20 INFO - MultiFileLogger online at 20160701 01:19:20 in /builds/slave/test 01:19:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:19:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:19:20 INFO - {'append_to_log': False, 01:19:20 INFO - 'base_work_dir': '/builds/slave/test', 01:19:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:19:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:19:20 INFO - 'branch': 'Mozilla-Inbound', 01:19:20 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:20 INFO - 'config_files': ('talos/linux_config.py',), 01:19:20 INFO - 'default_actions': ('clobber', 01:19:20 INFO - 'read-buildbot-config', 01:19:20 INFO - 'download-and-extract', 01:19:20 INFO - 'populate-webroot', 01:19:20 INFO - 'create-virtualenv', 01:19:20 INFO - 'install', 01:19:20 INFO - 'run-tests'), 01:19:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:20 INFO - 'download_minidump_stackwalk': True, 01:19:20 INFO - 'download_symbols': 'ondemand', 01:19:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:20 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:20 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:20 INFO - 'installer_path': 'installer.exe', 01:19:20 INFO - 'log_level': 'info', 01:19:20 INFO - 'log_name': 'talos', 01:19:20 INFO - 'log_to_console': True, 01:19:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:19:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:19:20 INFO - 'opt_config_files': (), 01:19:20 INFO - 'pip_index': False, 01:19:20 INFO - 'sps_profile': False, 01:19:20 INFO - 'sps_profile_interval': 0, 01:19:20 INFO - 'suite': 'dromaeojs-e10s', 01:19:20 INFO - 'system_bits': '32', 01:19:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:20 INFO - 'title': 'talos-linux64-ix-063', 01:19:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:20 INFO - 'use_talos_json': True, 01:19:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:19:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:20 INFO - 'work_dir': 'build'} 01:19:20 INFO - ##### 01:19:20 INFO - ##### Running clobber step. 01:19:20 INFO - ##### 01:19:20 INFO - Running pre-action listener: _resource_record_pre_action 01:19:20 INFO - Running main action method: clobber 01:19:20 INFO - rmtree: /builds/slave/test/build 01:19:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:19:20 INFO - Running post-action listener: _resource_record_post_action 01:19:20 INFO - ##### 01:19:20 INFO - ##### Finished clobber step (success) 01:19:20 INFO - ##### 01:19:20 INFO - ##### 01:19:20 INFO - ##### Running read-buildbot-config step. 01:19:20 INFO - ##### 01:19:20 INFO - Running pre-action listener: _resource_record_pre_action 01:19:20 INFO - Running main action method: read_buildbot_config 01:19:20 INFO - Using buildbot properties: 01:19:20 INFO - { 01:19:20 INFO - "project": "", 01:19:20 INFO - "product": "firefox", 01:19:20 INFO - "script_repo_revision": "production", 01:19:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:19:20 INFO - "repository": "", 01:19:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:19:20 INFO - "buildid": "20160630223048", 01:19:20 INFO - "pgo_build": "True", 01:19:20 INFO - "basedir": "/builds/slave/test", 01:19:20 INFO - "buildnumber": 938, 01:19:20 INFO - "slavename": "talos-linux64-ix-063", 01:19:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:19:20 INFO - "platform": "ubuntu64_hw", 01:19:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:19:20 INFO - "branch": "mozilla-inbound", 01:19:20 INFO - "repo_path": "integration/mozilla-inbound", 01:19:20 INFO - "revision": "0a03bb6af6043ce323142d24fb43c2d63deefbcb", 01:19:20 INFO - "stage_platform": "linux64-pgo", 01:19:20 INFO - "builduid": "5ae973d5ba3f4eb69efe800ddf7f84d7", 01:19:20 INFO - "slavebuilddir": "test" 01:19:20 INFO - } 01:19:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:19:20 INFO - Running post-action listener: _resource_record_post_action 01:19:20 INFO - ##### 01:19:20 INFO - ##### Finished read-buildbot-config step (success) 01:19:20 INFO - ##### 01:19:20 INFO - ##### 01:19:20 INFO - ##### Running download-and-extract step. 01:19:20 INFO - ##### 01:19:20 INFO - Running pre-action listener: _resource_record_pre_action 01:19:20 INFO - Running main action method: download_and_extract 01:19:20 INFO - mkdir: /builds/slave/test/build/tests 01:19: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')]} 01:19:20 INFO - https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:19:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:19:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:19:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:24 INFO - Downloaded 1361 bytes. 01:19:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:19:24 INFO - Using the following test package requirements: 01:19:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:19:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:19:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'jsshell-linux-x86_64.zip'], 01:19:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:19:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:19:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:19:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:19:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:19:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:24 INFO - https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:25 INFO - Downloaded 24270439 bytes. 01:19:25 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'] 01:19:25 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 01:19:26 INFO - Return code: 0 01:19:26 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 01:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:26 INFO - https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:19:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:34 INFO - Downloaded 24270439 bytes. 01:19:34 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'] 01:19:34 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 01:19:35 INFO - Return code: 0 01:19:35 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')]} 01:19:35 INFO - https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:19:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:19:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:19:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:37 INFO - Downloaded 14405242 bytes. 01:19:37 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'] 01:19:37 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 01:19:38 INFO - Return code: 0 01:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:38 INFO - https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:19:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/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 01:19:40 INFO - Downloaded 60331945 bytes. 01:19:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:40 INFO - mkdir: /builds/slave/test/properties 01:19:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:19:40 INFO - Writing to file /builds/slave/test/properties/build_url 01:19:40 INFO - Contents: 01:19:40 INFO - build_url:https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:41 INFO - Running post-action listener: _resource_record_post_action 01:19:41 INFO - Running post-action listener: set_extra_try_arguments 01:19:41 INFO - ##### 01:19:41 INFO - ##### Finished download-and-extract step (success) 01:19:41 INFO - ##### 01:19:41 INFO - ##### 01:19:41 INFO - ##### Running populate-webroot step. 01:19:41 INFO - ##### 01:19:41 INFO - Running pre-action listener: _resource_record_pre_action 01:19:41 INFO - Running main action method: populate_webroot 01:19:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:41 INFO - '--tppagecycles', 01:19:41 INFO - '7'], 01:19:41 INFO - 'tests': ['tsvgm']}}, 01:19:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:19:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:19:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:19:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['damp', 'tps']}, 01:19:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'tests': ['damp', 'tps']}, 01:19:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['dromaeo_dom']}, 01:19:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['basic_compositor_video']}, 01:19:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:19:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['a11yr', 01:19:41 INFO - 'ts_paint', 01:19:41 INFO - 'tpaint', 01:19:41 INFO - 'sessionrestore', 01:19:41 INFO - 'sessionrestore_no_auto_restore', 01:19:41 INFO - 'tabpaint']}, 01:19:41 INFO - 'other-e10s': {'tests': ['a11yr', 01:19:41 INFO - 'ts_paint', 01:19:41 INFO - 'tpaint', 01:19:41 INFO - 'sessionrestore', 01:19:41 INFO - 'sessionrestore_no_auto_restore', 01:19:41 INFO - 'tabpaint']}, 01:19:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:19:41 INFO - 'ts_paint', 01:19:41 INFO - 'tpaint', 01:19:41 INFO - 'sessionrestore', 01:19:41 INFO - 'sessionrestore_no_auto_restore', 01:19:41 INFO - 'tabpaint']}, 01:19:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:19:41 INFO - 'ts_paint', 01:19:41 INFO - 'tpaint', 01:19:41 INFO - 'sessionrestore', 01:19:41 INFO - 'sessionrestore_no_auto_restore', 01:19:41 INFO - 'tabpaint']}, 01:19:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['a11yr', 01:19:41 INFO - 'ts_paint', 01:19:41 INFO - 'tpaint', 01:19:41 INFO - 'sessionrestore', 01:19:41 INFO - 'sessionrestore_no_auto_restore', 01:19:41 INFO - 'tabpaint']}, 01:19:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['a11yr', 01:19:41 INFO - 'ts_paint', 01:19:41 INFO - 'tpaint', 01:19:41 INFO - 'sessionrestore', 01:19:41 INFO - 'sessionrestore_no_auto_restore', 01:19:41 INFO - 'tabpaint']}, 01:19:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['tsvgx', 01:19:41 INFO - 'tsvgr_opacity', 01:19:41 INFO - 'tart', 01:19:41 INFO - 'tscrollx', 01:19:41 INFO - 'cart']}, 01:19:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:19:41 INFO - 'tsvgr_opacity', 01:19:41 INFO - 'tart', 01:19:41 INFO - 'tscrollx', 01:19:41 INFO - 'cart']}, 01:19:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'talos_options': ['--disable-e10s'], 01:19:41 INFO - 'tests': ['tp5o']}, 01:19:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'tests': ['tp5o']}, 01:19:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'talos_options': ['--disable-e10s', 01:19:41 INFO - '--xperf_path', 01:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:41 INFO - 'tests': ['tp5n']}, 01:19:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:41 INFO - 'talos_options': ['--xperf_path', 01:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:41 INFO - 'tests': ['tp5n']}}, 01:19:41 INFO - 'talos.zip': {'path': '', 01:19:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:41 INFO - Running post-action listener: _resource_record_post_action 01:19:41 INFO - ##### 01:19:41 INFO - ##### Finished populate-webroot step (success) 01:19:41 INFO - ##### 01:19:41 INFO - ##### 01:19:41 INFO - ##### Running create-virtualenv step. 01:19:41 INFO - ##### 01:19:41 INFO - Running pre-action listener: _resource_record_pre_action 01:19:41 INFO - Running main action method: create_virtualenv 01:19:41 INFO - Creating virtualenv /builds/slave/test/build/venv 01:19:41 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 01:19:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:19:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:19:41 INFO - Using real prefix '/usr' 01:19:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:19:41 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:43 INFO - Installing pip.................done. 01:19:43 INFO - Return code: 0 01:19:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:19:43 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')]} 01:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:43 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')]} 01:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:43 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:19:43 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 01:19:43 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 01:19:43 INFO - Using env: {'DISPLAY': ':0', 01:19:43 INFO - 'HOME': '/home/cltbld', 01:19:43 INFO - 'LANG': 'en_US.UTF-8', 01:19:43 INFO - 'LANGUAGE': 'en_US:en', 01:19:43 INFO - 'LOGNAME': 'cltbld', 01:19:43 INFO - 'MAIL': '/var/mail/cltbld', 01:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:43 INFO - 'MOZ_NO_REMOTE': '1', 01:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:43 INFO - 'NO_EM_RESTART': '1', 01:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:43 INFO - 'PWD': '/builds/slave/test', 01:19:43 INFO - 'SHELL': '/bin/bash', 01:19:43 INFO - 'SHLVL': '1', 01:19:43 INFO - 'TERM': 'linux', 01:19:43 INFO - 'TMOUT': '86400', 01:19:43 INFO - 'USER': 'cltbld', 01:19:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:43 INFO - '_': '/tools/buildbot/bin/python'} 01:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:43 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 01:19:43 INFO - Cleaning up... 01:19:43 INFO - Return code: 0 01:19:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:19:43 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')]} 01:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:43 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')]} 01:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:43 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:19:43 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 01:19:43 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 01:19:43 INFO - Using env: {'DISPLAY': ':0', 01:19:43 INFO - 'HOME': '/home/cltbld', 01:19:43 INFO - 'LANG': 'en_US.UTF-8', 01:19:43 INFO - 'LANGUAGE': 'en_US:en', 01:19:43 INFO - 'LOGNAME': 'cltbld', 01:19:43 INFO - 'MAIL': '/var/mail/cltbld', 01:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:43 INFO - 'MOZ_NO_REMOTE': '1', 01:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:43 INFO - 'NO_EM_RESTART': '1', 01:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:43 INFO - 'PWD': '/builds/slave/test', 01:19:43 INFO - 'SHELL': '/bin/bash', 01:19:43 INFO - 'SHLVL': '1', 01:19:43 INFO - 'TERM': 'linux', 01:19:43 INFO - 'TMOUT': '86400', 01:19:43 INFO - 'USER': 'cltbld', 01:19:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:43 INFO - '_': '/tools/buildbot/bin/python'} 01:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:44 INFO - Downloading/unpacking psutil>=3.1.1 01:19:44 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 01:19:44 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 01:19:44 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 01:19:44 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 01:19:44 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 01:19:44 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 01:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:46 INFO - Installing collected packages: psutil 01:19:46 INFO - Running setup.py install for psutil 01:19:46 INFO - building 'psutil._psutil_linux' extension 01:19:46 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 01:19:46 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 01:19:46 INFO - building 'psutil._psutil_posix' extension 01:19:46 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 01:19:46 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 01:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:46 INFO - Successfully installed psutil 01:19:46 INFO - Cleaning up... 01:19:46 INFO - Return code: 0 01:19:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:46 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:19:46 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 01:19:46 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 01:19:46 INFO - Using env: {'DISPLAY': ':0', 01:19:46 INFO - 'HOME': '/home/cltbld', 01:19:46 INFO - 'LANG': 'en_US.UTF-8', 01:19:46 INFO - 'LANGUAGE': 'en_US:en', 01:19:46 INFO - 'LOGNAME': 'cltbld', 01:19:46 INFO - 'MAIL': '/var/mail/cltbld', 01:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:46 INFO - 'MOZ_NO_REMOTE': '1', 01:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:46 INFO - 'NO_EM_RESTART': '1', 01:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:46 INFO - 'PWD': '/builds/slave/test', 01:19:46 INFO - 'SHELL': '/bin/bash', 01:19:46 INFO - 'SHLVL': '1', 01:19:46 INFO - 'TERM': 'linux', 01:19:46 INFO - 'TMOUT': '86400', 01:19:46 INFO - 'USER': 'cltbld', 01:19:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:46 INFO - '_': '/tools/buildbot/bin/python'} 01:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19:46 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 01:19:46 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 01:19:46 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 01:19:46 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 01:19:46 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 01:19:46 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 01:19:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:19:48 INFO - Installing collected packages: mozsystemmonitor 01:19:48 INFO - Running setup.py install for mozsystemmonitor 01:19:48 INFO - Successfully installed mozsystemmonitor 01:19:48 INFO - Cleaning up... 01:19:48 INFO - Return code: 0 01:19:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:48 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')]} 01:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:48 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')]} 01:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:48 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:19:48 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 01:19:48 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 01:19:48 INFO - Using env: {'DISPLAY': ':0', 01:19:48 INFO - 'HOME': '/home/cltbld', 01:19:48 INFO - 'LANG': 'en_US.UTF-8', 01:19:48 INFO - 'LANGUAGE': 'en_US:en', 01:19:48 INFO - 'LOGNAME': 'cltbld', 01:19:48 INFO - 'MAIL': '/var/mail/cltbld', 01:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:48 INFO - 'MOZ_NO_REMOTE': '1', 01:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:48 INFO - 'NO_EM_RESTART': '1', 01:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:48 INFO - 'PWD': '/builds/slave/test', 01:19:48 INFO - 'SHELL': '/bin/bash', 01:19:48 INFO - 'SHLVL': '1', 01:19:48 INFO - 'TERM': 'linux', 01:19:48 INFO - 'TMOUT': '86400', 01:19:48 INFO - 'USER': 'cltbld', 01:19:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:48 INFO - '_': '/tools/buildbot/bin/python'} 01:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:49 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:49 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 01:19:49 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 01:19:49 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 01:19:49 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 01:19:49 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 01:19:49 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 01:19:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:51 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:51 INFO - warning: no files found matching '*.txt' 01:19:51 INFO - no previously-included directories found matching 'build' 01:19:51 INFO - no previously-included directories found matching 'dist' 01:19:51 INFO - no previously-included directories found matching '.git*' 01:19:51 INFO - Installing collected packages: jsonschema, functools32 01:19:51 INFO - Running setup.py install for functools32 01:19:51 INFO - warning: no files found matching '*.txt' 01:19:51 INFO - no previously-included directories found matching 'build' 01:19:51 INFO - no previously-included directories found matching 'dist' 01:19:51 INFO - no previously-included directories found matching '.git*' 01:19:51 INFO - Successfully installed jsonschema functools32 01:19:51 INFO - Cleaning up... 01:19:51 INFO - Return code: 0 01:19:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:19: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')]} 01:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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')]} 01:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:19:51 INFO - Using env: {'DISPLAY': ':0', 01:19:51 INFO - 'HOME': '/home/cltbld', 01:19:51 INFO - 'LANG': 'en_US.UTF-8', 01:19:51 INFO - 'LANGUAGE': 'en_US:en', 01:19:51 INFO - 'LOGNAME': 'cltbld', 01:19:51 INFO - 'MAIL': '/var/mail/cltbld', 01:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:51 INFO - 'MOZ_NO_REMOTE': '1', 01:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:51 INFO - 'NO_EM_RESTART': '1', 01:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:51 INFO - 'PWD': '/builds/slave/test', 01:19:51 INFO - 'SHELL': '/bin/bash', 01:19:51 INFO - 'SHLVL': '1', 01:19:51 INFO - 'TERM': 'linux', 01:19:51 INFO - 'TMOUT': '86400', 01:19:51 INFO - 'USER': 'cltbld', 01:19:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:51 INFO - '_': '/tools/buildbot/bin/python'} 01:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:51 INFO - Downloading/unpacking blobuploader==1.2.4 01:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:53 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:54 INFO - Downloading docopt-0.6.1.tar.gz 01:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:54 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:54 INFO - Running setup.py install for blobuploader 01:19:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:54 INFO - Running setup.py install for requests 01:19:54 INFO - Running setup.py install for docopt 01:19:54 INFO - Successfully installed blobuploader requests docopt 01:19:54 INFO - Cleaning up... 01:19:55 INFO - Return code: 0 01:19:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:55 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')]} 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:55 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')]} 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:55 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:19:55 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 01:19:55 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 01:19:55 INFO - Using env: {'DISPLAY': ':0', 01:19:55 INFO - 'HOME': '/home/cltbld', 01:19:55 INFO - 'LANG': 'en_US.UTF-8', 01:19:55 INFO - 'LANGUAGE': 'en_US:en', 01:19:55 INFO - 'LOGNAME': 'cltbld', 01:19:55 INFO - 'MAIL': '/var/mail/cltbld', 01:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:55 INFO - 'MOZ_NO_REMOTE': '1', 01:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:55 INFO - 'NO_EM_RESTART': '1', 01:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:55 INFO - 'PWD': '/builds/slave/test', 01:19:55 INFO - 'SHELL': '/bin/bash', 01:19:55 INFO - 'SHLVL': '1', 01:19:55 INFO - 'TERM': 'linux', 01:19:55 INFO - 'TMOUT': '86400', 01:19:55 INFO - 'USER': 'cltbld', 01:19:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:55 INFO - '_': '/tools/buildbot/bin/python'} 01:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:55 INFO - Running setup.py (path:/tmp/pip-aE003r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:55 INFO - Running setup.py (path:/tmp/pip-FsdYtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:55 INFO - Running setup.py (path:/tmp/pip-TnaVJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:55 INFO - Running setup.py (path:/tmp/pip-u7RLnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:55 INFO - Running setup.py (path:/tmp/pip-OhJSsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:55 INFO - Running setup.py (path:/tmp/pip-QTR9LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:55 INFO - Running setup.py (path:/tmp/pip-Hx6v9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:55 INFO - Running setup.py (path:/tmp/pip-fb58WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:55 INFO - Running setup.py (path:/tmp/pip-Y9o1oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:55 INFO - Running setup.py (path:/tmp/pip-5gStPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:55 INFO - Running setup.py (path:/tmp/pip-suMuGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:56 INFO - Running setup.py (path:/tmp/pip-_XgCAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:56 INFO - Running setup.py (path:/tmp/pip-JgjZGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:56 INFO - Running setup.py (path:/tmp/pip-j11m3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:56 INFO - Running setup.py (path:/tmp/pip-Ri74p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:56 INFO - Running setup.py (path:/tmp/pip-dQAHHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:56 INFO - Running setup.py (path:/tmp/pip-sxWJqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:56 INFO - Running setup.py install for manifestparser 01:19:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:56 INFO - Running setup.py install for mozcrash 01:19:56 INFO - Running setup.py install for mozdebug 01:19:56 INFO - Running setup.py install for mozdevice 01:19:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:56 INFO - Running setup.py install for mozfile 01:19:56 INFO - Running setup.py install for mozhttpd 01:19:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozinfo 01:19:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozInstall 01:19:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozleak 01:19:57 INFO - Running setup.py install for mozlog 01:19:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for moznetwork 01:19:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozprocess 01:19:57 INFO - Running setup.py install for mozprofile 01:19:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozrunner 01:19:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozscreenshot 01:19:58 INFO - Running setup.py install for moztest 01:19:58 INFO - Running setup.py install for mozversion 01:19:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:58 INFO - Cleaning up... 01:19:58 INFO - Return code: 0 01:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:58 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:19:58 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 01:19:58 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 01:19:58 INFO - Using env: {'DISPLAY': ':0', 01:19:58 INFO - 'HOME': '/home/cltbld', 01:19:58 INFO - 'LANG': 'en_US.UTF-8', 01:19:58 INFO - 'LANGUAGE': 'en_US:en', 01:19:58 INFO - 'LOGNAME': 'cltbld', 01:19:58 INFO - 'MAIL': '/var/mail/cltbld', 01:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:58 INFO - 'MOZ_NO_REMOTE': '1', 01:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:58 INFO - 'NO_EM_RESTART': '1', 01:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:58 INFO - 'PWD': '/builds/slave/test', 01:19:58 INFO - 'SHELL': '/bin/bash', 01:19:58 INFO - 'SHLVL': '1', 01:19:58 INFO - 'TERM': 'linux', 01:19:58 INFO - 'TMOUT': '86400', 01:19:58 INFO - 'USER': 'cltbld', 01:19:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:58 INFO - '_': '/tools/buildbot/bin/python'} 01:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:58 INFO - Running setup.py (path:/tmp/pip-YNaGpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:58 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)) 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:58 INFO - Running setup.py (path:/tmp/pip-rUnNkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:58 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)) 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:58 INFO - Running setup.py (path:/tmp/pip-Ibpusr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:58 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)) 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:58 INFO - Running setup.py (path:/tmp/pip-GnFmD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:58 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)) 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:58 INFO - Running setup.py (path:/tmp/pip-QE9hVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:58 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)) 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:58 INFO - Running setup.py (path:/tmp/pip-UEEe7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:58 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)) 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:58 INFO - Running setup.py (path:/tmp/pip-LYYgMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:58 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)) 01:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:58 INFO - Running setup.py (path:/tmp/pip-x05nun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:59 INFO - Running setup.py (path:/tmp/pip-5C8wrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:59 INFO - Running setup.py (path:/tmp/pip-_4sD0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:59 INFO - Running setup.py (path:/tmp/pip-aSZfrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:59 INFO - Running setup.py (path:/tmp/pip-KLIFsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:59 INFO - Running setup.py (path:/tmp/pip-uoQ6As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:59 INFO - Running setup.py (path:/tmp/pip-68bT8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:59 INFO - Running setup.py (path:/tmp/pip-QsYw_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:59 INFO - Running setup.py (path:/tmp/pip-YIoKUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:59 INFO - Running setup.py (path:/tmp/pip-hsQ5Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:59 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)) 01:19:59 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)) 01:19:59 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)) 01:19:59 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)) 01:19:59 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)) 01:19:59 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)) 01:19:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:19:59 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 01:19:59 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 01:19:59 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 01:19:59 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 01:19:59 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 01:19:59 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 01:20:01 INFO - Downloading blessings-1.6.tar.gz 01:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:20:01 INFO - Installing collected packages: blessings 01:20:01 INFO - Running setup.py install for blessings 01:20:01 INFO - Successfully installed blessings 01:20:01 INFO - Cleaning up... 01:20:01 INFO - Return code: 0 01:20:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:20:01 INFO - Reading from file tmpfile_stdout 01:20:01 INFO - Current package versions: 01:20:01 INFO - argparse == 1.2.1 01:20:01 INFO - blessings == 1.6 01:20:01 INFO - blobuploader == 1.2.4 01:20:01 INFO - docopt == 0.6.1 01:20:01 INFO - functools32 == 3.2.3-2 01:20:01 INFO - jsonschema == 2.5.1 01:20:01 INFO - manifestparser == 1.1 01:20:01 INFO - mozInstall == 1.12 01:20:01 INFO - mozcrash == 0.17 01:20:01 INFO - mozdebug == 0.1 01:20:01 INFO - mozdevice == 0.48 01:20:01 INFO - mozfile == 1.2 01:20:01 INFO - mozhttpd == 0.7 01:20:01 INFO - mozinfo == 0.9 01:20:01 INFO - mozleak == 0.1 01:20:01 INFO - mozlog == 3.2 01:20:01 INFO - moznetwork == 0.27 01:20:01 INFO - mozprocess == 0.22 01:20:01 INFO - mozprofile == 0.28 01:20:01 INFO - mozrunner == 6.11 01:20:01 INFO - mozscreenshot == 0.1 01:20:01 INFO - mozsystemmonitor == 0.3 01:20:01 INFO - moztest == 0.7 01:20:01 INFO - mozversion == 1.4 01:20:01 INFO - psutil == 3.1.1 01:20:01 INFO - requests == 1.2.3 01:20:01 INFO - wsgiref == 0.1.2 01:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:20: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')]} 01:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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')]} 01:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:01 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:20:01 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 01:20:01 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 01:20:01 INFO - Using env: {'DISPLAY': ':0', 01:20:01 INFO - 'HOME': '/home/cltbld', 01:20:01 INFO - 'LANG': 'en_US.UTF-8', 01:20:01 INFO - 'LANGUAGE': 'en_US:en', 01:20:01 INFO - 'LOGNAME': 'cltbld', 01:20:01 INFO - 'MAIL': '/var/mail/cltbld', 01:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:01 INFO - 'MOZ_NO_REMOTE': '1', 01:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:01 INFO - 'NO_EM_RESTART': '1', 01:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:01 INFO - 'PWD': '/builds/slave/test', 01:20:01 INFO - 'SHELL': '/bin/bash', 01:20:01 INFO - 'SHLVL': '1', 01:20:01 INFO - 'TERM': 'linux', 01:20:01 INFO - 'TMOUT': '86400', 01:20:01 INFO - 'USER': 'cltbld', 01:20:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:01 INFO - '_': '/tools/buildbot/bin/python'} 01:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 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)) 01:20:02 INFO - Cleaning up... 01:20:02 INFO - Return code: 0 01:20:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:02 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 0x1f9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, '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': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', '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 01:20:02 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 01:20:02 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 01:20:02 INFO - Using env: {'DISPLAY': ':0', 01:20:02 INFO - 'HOME': '/home/cltbld', 01:20:02 INFO - 'LANG': 'en_US.UTF-8', 01:20:02 INFO - 'LANGUAGE': 'en_US:en', 01:20:02 INFO - 'LOGNAME': 'cltbld', 01:20:02 INFO - 'MAIL': '/var/mail/cltbld', 01:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:02 INFO - 'MOZ_NO_REMOTE': '1', 01:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:02 INFO - 'NO_EM_RESTART': '1', 01:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:02 INFO - 'PWD': '/builds/slave/test', 01:20:02 INFO - 'SHELL': '/bin/bash', 01:20:02 INFO - 'SHLVL': '1', 01:20:02 INFO - 'TERM': 'linux', 01:20:02 INFO - 'TMOUT': '86400', 01:20:02 INFO - 'USER': 'cltbld', 01:20:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:02 INFO - '_': '/tools/buildbot/bin/python'} 01:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:20:02 INFO - Cleaning up... 01:20:02 INFO - Return code: 0 01:20:02 INFO - Running post-action listener: _resource_record_post_action 01:20:02 INFO - Running post-action listener: _start_resource_monitoring 01:20:02 INFO - Starting resource monitoring. 01:20:02 INFO - ##### 01:20:02 INFO - ##### Finished create-virtualenv step (success) 01:20:02 INFO - ##### 01:20:02 INFO - ##### 01:20:02 INFO - ##### Running install step. 01:20:02 INFO - ##### 01:20:02 INFO - Running pre-action listener: _resource_record_pre_action 01:20:02 INFO - Running main action method: install 01:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:20:02 INFO - Reading from file tmpfile_stdout 01:20:02 INFO - Detecting whether we're running mozinstall >=1.0... 01:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:20:02 INFO - Reading from file tmpfile_stdout 01:20:02 INFO - Output received: 01:20:02 INFO - Usage: mozinstall [options] installer 01:20:02 INFO - Options: 01:20:02 INFO - -h, --help show this help message and exit 01:20:02 INFO - -d DEST, --destination=DEST 01:20:02 INFO - Directory to install application into. [default: 01:20:02 INFO - "/builds/slave/test"] 01:20:02 INFO - --app=APP Application being installed. [default: firefox] 01:20:02 INFO - mkdir: /builds/slave/test/build/application 01:20:02 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'] 01:20:02 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 01:20:25 INFO - Reading from file tmpfile_stdout 01:20:25 INFO - Output received: 01:20:25 INFO - /builds/slave/test/build/application/firefox/firefox 01:20:25 INFO - Running post-action listener: _resource_record_post_action 01:20:25 INFO - ##### 01:20:25 INFO - ##### Finished install step (success) 01:20:25 INFO - ##### 01:20:25 INFO - ##### 01:20:25 INFO - ##### Running run-tests step. 01:20:25 INFO - ##### 01:20:25 INFO - Running pre-action listener: _resource_record_pre_action 01:20:25 INFO - Running main action method: run_tests 01:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:20:25 INFO - Python 2.7.3 01:20:25 INFO - Return code: 0 01:20:25 INFO - grabbing minidump binary from tooltool 01:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:25 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 0x2258570>, '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 0x2259470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:25 INFO - Return code: 0 01:20:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:20:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:20:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:20:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:20:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:20:25 INFO - Using env: {'DISPLAY': ':0', 01:20:25 INFO - 'HOME': '/home/cltbld', 01:20:25 INFO - 'LANG': 'en_US.UTF-8', 01:20:25 INFO - 'LANGUAGE': 'en_US:en', 01:20:25 INFO - 'LOGNAME': 'cltbld', 01:20:25 INFO - 'MAIL': '/var/mail/cltbld', 01:20:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:20:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:25 INFO - 'MOZ_NO_REMOTE': '1', 01:20:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:25 INFO - 'NO_EM_RESTART': '1', 01:20:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:25 INFO - 'PWD': '/builds/slave/test', 01:20:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:20:25 INFO - 'SHELL': '/bin/bash', 01:20:25 INFO - 'SHLVL': '1', 01:20:25 INFO - 'TERM': 'linux', 01:20:25 INFO - 'TMOUT': '86400', 01:20:25 INFO - 'USER': 'cltbld', 01:20:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560', 01:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:25 INFO - '_': '/tools/buildbot/bin/python'} 01:20:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:20:25 INFO - mozversion application_buildid: 20160630223048 01:20:25 INFO - mozversion application_changeset: 0a03bb6af6043ce323142d24fb43c2d63deefbcb 01:20:25 INFO - mozversion application_display_name: Nightly 01:20:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:25 INFO - mozversion application_name: Firefox 01:20:25 INFO - mozversion application_remotingname: firefox 01:20:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:20:25 INFO - mozversion application_vendor: Mozilla 01:20:25 INFO - mozversion application_version: 50.0a1 01:20:25 INFO - mozversion platform_buildid: 20160630223048 01:20:25 INFO - mozversion platform_changeset: 0a03bb6af6043ce323142d24fb43c2d63deefbcb 01:20:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:20:25 INFO - mozversion platform_version: 50.0a1 01:20:25 INFO - using testdate: 1467361225 01:20:25 INFO - actual date: 1467361225 01:20:25 INFO - starting webserver on 'localhost:59726' 01:20:25 INFO - SUITE-START | Running 2 tests 01:20:25 INFO - TEST-START | dromaeo_css 01:20:25 INFO - operating with platform_type : linux_ 01:20:25 INFO - Initialising browser for dromaeo_css test... 01:20:25 INFO - TEST-INFO | started process 15007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNzvCh/profile http://localhost:59726/getInfo.html) 01:20:51 INFO - PROCESS | 15007 | __metrics Screen width/height:1600/1200 01:20:51 INFO - PROCESS | 15007 | colorDepth:24 01:20:51 INFO - PROCESS | 15007 | Browser inner width/height: 1024/697 01:20:51 INFO - PROCESS | 15007 | __metrics 01:21:04 ERROR - PROCESS | 15007 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:21:05 INFO - TEST-INFO | 15007: exit 0 01:21:05 INFO - Browser initialized. 01:21:05 INFO - Running cycle 1/1 for dromaeo_css test... 01:21:05 INFO - TEST-INFO | started process 15132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNzvCh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:21:16 INFO - PROCESS | 15132 | RSS: Main: 168144896 01:21:16 INFO - PROCESS | 15132 | 01:22:06 INFO - PROCESS | 15132 | 1467361326583 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] 01:24:14 INFO - PROCESS | 15132 | Cycle 1(1): loaded http://localhost:59726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59726/tests/dromaeo/cssquery-ext.html) 01:24:15 INFO - PROCESS | 15132 | RSS: Main: 172011520 01:24:15 INFO - PROCESS | 15132 | 01:27:17 INFO - PROCESS | 15132 | Cycle 1(1): loaded http://localhost:59726/tests/dromaeo/cssquery-ext.html (next: http://localhost:59726/tests/dromaeo/cssquery-jquery.html) 01:27:18 INFO - PROCESS | 15132 | RSS: Main: 168792064 01:27:18 INFO - PROCESS | 15132 | 01:30:20 INFO - PROCESS | 15132 | Cycle 1(1): loaded http://localhost:59726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59726/tests/dromaeo/cssquery-mootools.html) 01:30:20 INFO - PROCESS | 15132 | RSS: Main: 172142592 01:30:20 INFO - PROCESS | 15132 | 01:33:22 INFO - PROCESS | 15132 | Cycle 1(1): loaded http://localhost:59726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59726/tests/dromaeo/cssquery-prototype.html) 01:33:23 INFO - PROCESS | 15132 | RSS: Main: 167718912 01:33:23 INFO - PROCESS | 15132 | 01:36:25 INFO - PROCESS | 15132 | Cycle 1(1): loaded http://localhost:59726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59726/tests/dromaeo/cssquery-yui.html) 01:36:26 INFO - PROCESS | 15132 | RSS: Main: 169811968 01:36:26 INFO - PROCESS | 15132 | 01:39:28 INFO - PROCESS | 15132 | Cycle 1(1): loaded http://localhost:59726/tests/dromaeo/cssquery-yui.html (next: http://localhost:59726/tests/dromaeo/cssquery-dojo.html) 01:39:29 INFO - PROCESS | 15132 | RSS: Main: 171462656 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | __start_tp_report 01:39:29 INFO - PROCESS | 15132 | _x_x_mozilla_page_load 01:39:29 INFO - PROCESS | 15132 | _x_x_mozilla_page_load_details 01:39:29 INFO - PROCESS | 15132 | |i|pagename|runs| 01:39:29 INFO - PROCESS | 15132 | |0;dojo.html;3087.1664650544353;3165.003024047425;3168.3188114555364;3191.9042428727116;3199.472087105628;5403.810866619664;5451.37309209441;5480.862978425542;5541.861453463665;5545.694986775736;5326.946730532693;5404.135338345865;5464.9453505464935;5472.808451704191;5496.148097044955;4981.178105612578;5009.148444764399;5108.4636113208135;5155.072087024334;5209.947900520984;612.0453039719849;4736.881577960561;4902.362692849924;4919.557239848413;5113.258577506278;4953.4303555091265;4970.080535101018;4997.225430058346;5002.824901128443;5008.699478031293;4983.825566105205;5011.874703132415;5027.824026159104;5033.521815427529;5045.243213517965;4941.827036053721;4945;4991.450940396553;5020.071286811952;5032.572231360339;5442.12925931853;5485.753141108659;5514.0901751211;5568.860778480571;5576.079946808772;5667.801626943078;5726.885462290731;5892.852678683024;5960.225170727777;5976.97011514944;5744.655320680772;5814;5821.27234095738;5841.970790146064;5883.970580147115;5367.436419176009;5415.404305526428;5436.755346009439;5439.48324909133;5448.809291674812;5759.1649210865025;5844.211031510777;5868.530517558585;5894.4400281974;5932.436418540232;5632.746526406321;5721.5136713379;5721.656700597978;5731.598788084877;5789.652620842763;5750.568707346882;5761.567882408753;5834.095715164156;5839.649621022667;5841.036229022164;5570.916436253459;5798.594098413155;5807.12893066035;5872.500837428781;5883.764649414061;5875.882482350415;5924.289085309791;5931;5933.465988061095;5933.732982015819;4450.933236001462;4501.482329532146;4502.189605870909;4512.075024619945;4545.636349092065;3831.750936189139;3838.596947320491;3925.4896863407575;3929.548101968253;3978.462907507507;5592.888142237132;5601.383847776741;5629.971850140723;5631.605787594829;5643.7742490299925;5887.911681324698;5952.315483719428;6003.039513677791;6005.789797357159;6012.158297838306;5454.863628409242;5664.122061080539;5702.7433765480655;5721.370649228582;5781.508571771446;5019;5025.246213067996;5028.421731500851;5035.823746168867;5093.337866077386;5807.941920580824;6191.487452516942;6225.00399936008;6230.439260466489;6233.283172435228;5741.425857414225;5756.971215143897;5792.362840087502;5797.971010144923;5858.150568167506;5987.311459182076;5988.910166347596;6013.308469525886;6030.246219222598;6033.75864965414;5572.972135139298;5674.375818659862;5709.857253568528;5711.5716321276905;5770.394108618535;5903.114532820111;5951.16683664296;5967.343592204941;5978.940210597838;6040.516758659384;5774.624649397776;5790.594658373873;5830.766769329349;5834.883302333845;5861.9413805863105;5525.557955363642;5621.662700237999;5658.632188907708;5825.097109947965;5836.824895253149;5585.106382978704;5607.467290607386;5612.915806262828;5654.971725141348;5670.667393162521;5746.965546201556;5764.711764411846;5769.134629805395;5781.306243250837;5808.593398462067;5328.040952628409;5527.115661494142;5636.985342638364;5642.463965923231;5663.66018038919 01:39:29 INFO - PROCESS | 15132 | |1;ext.html;560.5319558168928;587.7355190164426;596.7463827873155;622.4149299658319;644.7098805537504;40304.193916121694;44216.557834421685;44250.55749442505;44261;44317.33523997143;44344.77827610866;44787.552124478745;44835.77582112085;44841.775791121;44889.32666010012;8940.061293564164;9071.773205669844;9094.818103637956;9102.772430689252;9121;8905.465672059665;8942.374033817636;8977.236934860544;9001.909980900205;9024.639014439448;9049;9062.954685226598;9107.316951228651;9120.17918387345;9137.588808503633;8990.28077753778;9095.545222738903;9101.135392137736;9107.499087550183;9108.954455227682;8958.910410895873;9001.144891235323;9013.594388252544;9033.322500812465;9041.457512549268;42370;42577;42846;43003;43042.35436468456;2670.465906818644;3323.21904352477;3600.6939410150167;3747.8126093695205;4039.9192016159514;32666.510002349984;32810.50784238238;32850.67149328524;33201.33597328064;33246.50130248048;4177.644900183488;4380.978095109536;4420.867373978754;4429.756363400012;4436.800343984529;315215;317896.4105179482;318304;318332;318625;37840.62159378371;37966.62033379631;37988.24023519514;37994.81002594969;37997.43003854944;38445;38921;39038.414423783666;39061.60938390637;39070;14006.929965350311;15641.530754077396;16031.438899638457;16049.679006419807;16403.753943690856;13419.731605368033;13520.053596248365;13536.25550594707;13578.524751633842;13633.045686801828;8920.375573709778;8932.106789321017;8974.820503589892;9008.279337653103;9037.322200834964;3455.605005288634;3469.635688252697;3482.425399809054;3523.5067090607336;3539.2744487380023;985.3299756165876;1004.8442491413697;1036.7045392063226;1046.49768111307;1106.5348845258172;33288;33542.16144596356;33546;33926.66073339284;34039.829800850835;1138.2373809547623;1209.5766481731323;1215.4834195467067;1233.586748439265;1242.6147894152662;17052.403165889384;17650.205740741698;17788.733169002477;17852.285908563772;17929.37247196342;593806;599870;602497;606065;607377;60708.392916071156;62266.68866655638;62644.686776565824;62724.68637656783;62918;1374.2098293481288;1374.8075269462283;1376.6558360409897;1378.7587172244816;1391.3113009060378;30321.696783031886;32756.34487310288;32783.180420489676;33120;33346.419324861956;54185;54608.45391546033;54616.72691636675;54874.451255486936;54915;505856;507096;509241;510955;515560;30137.246568835955;30618.234544136576;30746;30794.230144246572;30800.075997720105;49959.50040499549;50405.74797126138;50860.49139508558;51577.742111289204;52300.21549676682;43392.78303608462;44010;44365.77817110894;44648;45695.54304456913;42779.81857710523;42993.78503107464;43216.78391608022;43459.78270108629;44110.55889441064;34328.82835585806;38725.419118713806;40589.59410405858;43375;45178.77410612926;35521;38402.42396364001;38710.2257954845;38937.2212555753;39088.6091139085;28165.43669126647;28357.574636380883;28574.427986542425;28634.284142896595;28898 01:39:29 INFO - PROCESS | 15132 | |2;jquery.html;411.1345617475214;411.9608637179468;412.6265729514788;413.74968144272697;432.24141631436845;18751.906240468794;19888.105035273395;20225.696614550794;20489.590208195827;20926.790732092675;20070.799292007076;20233.79766202341;20620;20831.166753329886;20910.16359345628;5638.605297629168;5800.245968024172;5820.126980952869;5844.64932104073;5846.9707651461895;5537.889242215153;5546.69493177875;5560.805371811987;5601.943980560183;5660.3490598581075;5634.267545219136;5643.717814109299;5687.857803554903;5716.857078573027;5724.542036637059;5678.46054624812;5679.886402271952;5731.083026715747;5760.049591817345;5762.279715035621;5047.49525047496;5154.685555183404;5167.870803229912;5191.922121168185;5192.71440070796;23763.88118059416;23946.28161155168;24530.877345613157;24736.752632473625;24787.62818557705;2352.635341522067;2426.1872272788637;2655.349439387343;2659.2155314182364;3012.487877060905;14918.552443426715;14920.104793712411;14986.325615347336;15281.694366112726;15368.769468457982;1967.1934506852122;1984.82136607706;1987.2746447546685;2039.3881835449454;2111.229401268541;81251.5937420315;82917.58541207315;84688.57655711744;85189.4443166706;85264;10896.455177241107;11397.430128493543;11609.593664221711;11669.824952625717;11732.354720490284;15676.608084797972;15769.842301576837;15794;15837.287322070535;15854.365825367087;8529.701460448854;8676.436031657922;8900.332475064397;8918.687845925362;8950.328725345626;8528.84860543831;8584.098669639723;8625.482471051757;8665.2634526066;8749.56252187388;6903.859803460943;6988.44092472601;7067.363937245673;7138.535995160401;7177.664163604393;1996.3068323601512;2006.5384961458653;2036.867603605761;2040.2349119080345;2083.2083808152806;958.152035448619;970.315927271272;1007.3452256033637;1017.1760873692185;1068.289587424354;20113.592048556755;20884.686729699068;21049.158033678483;21077.367678969655;21159.15363385478;1037.5382954585136;1061.883192848786;1063.3407287481657;1071.8552995345685;1082.1288862465633;10596.89403105959;11869.643910682693;11947.701307467383;11964.64106076819;11975.52097916091;473872;475006;486468;489544;489679;63762;84757;84840;84949;85049.57475212708;998.6704387552236;1033.1631378583372;1060.289605964006;1061.1192710050639;1068.1721665709138;17646.558836029202;17880.195391207686;18383.540411489284;18437;18679.813201867808;38923;39072.21855562816;40049.59950400459;40366;40440.1911961765;52726;53843.53877534721;54249.45750542444;54466.72766636142;54790.17814732862;7932.920670793218;9140.451572905647;9248.861267080865;9289.953550232476;9626.278029147981;10045.69862904114;13831.861681383058;14361.712765744836;14550.490732824725;14565.85434145645;12167.878321216675;12474;12521.624351269476;12552.937235313764;12629.431675574804;12318.568850090203;12406.069544783997;12508.124431290087;12524.624261272176;12717.918976886698;12618.684532886751;12693;12928.612141635766;12941.482340706267;13060.738785224432;8370.16298370158;8370.455920365157;8378.622961966605;8570.52862092566;8651.134886511298;11230.887691122984;12610.49558017669;12679.23924564529;12689.555865544662;12892.548760793326 01:39:29 INFO - PROCESS | 15132 | |3;mootools.html;1409.422136923861;1467.6624376393431;1558.3922270314579;1785.1609743420595;1803.5941913069569;7767.68929242831;8515.53164575948;8791.20879120879;9267.814643707121;9279.164875161234;8890.42212256203;9020.774480637987;9238.86141707875;9250.35247532673;9278.814423711521;2353.6940197774306;2392.0670938334065;2395.341281147681;2398.4723360860585;2398.724146723123;2391.234804862445;2446.376174075608;2451.816113791464;2453.4479742058074;2460.9261722148362;2412.0472413396787;2423.127674037345;2425.4906469641396;2453.0555736041574;2454.754524547549;2335.5679199348174;2337.6844126043106;2358;2369.763023697634;2370.8696021718883;2310.9716176301554;2327.034280773477;2335.94160145996;2340.414896275931;2343.0627748900406;9245.537723113817;9265.166135047879;9346.532673366373;9367.297452691007;9397.577109030042;5431.728413579344;5536.197251398565;5541.473560011793;5547.77808887644;5550.084236101038;3426.6059403168706;3452.378571857065;3529.8941031769086;3545.3795585772386;3564.518789963374;1116.8994790468896;1117.5250518529592;1204.2172587817902;1214.1440284599337;2174.206414658654;11778.882211177865;12128.27230366172;12171.695707607292;12228.938855305756;12248;4434.600885920218;4642.9767851161205;4663.854626871677;4681;4700;9570.95214523923;9584;9617.56720947545;9621.759456013655;9668.9033109668;5387.973060134753;5393.27190829233;5404.540614047772;5472.288602481652;5516.724163791875;4243.936340954888;4918.803247870117;5116.104681680691;5122.129238029544;5164.3802743671;3860.4788353571907;3881.4177873319227;3980.5024371953505;3988.202359528106;4024.3158663027357;1175.5767923547517;1179;1180.8819118088122;1181.4565299962114;1194.2476239968764;887.9644814207488;961.6826447272523;974.1232890398697;978.7895602445366;985.1576901749045;5887.852803679943;5916.1421593868645;5956.523478121827;6073.908891366633;6217.6891155442045;451.28921947931485;452.87093178443985;459.7632219407008;462.85651448051215;463.3952691737315;4208;4455.287154055336;4473.843415480507;4495.707778994355;4554.544545545486;10641;11077.224594278485;11416;11473.483693233824;11643.767124657628;11225;11378.943105284587;11408.258463199865;11431.085513158927;11485.942570287096;8074.959625201836;8100.918990810134;8256.628451719687;8268.338532917352;8287.295579875657;6317.842053948504;6431.228252609717;6558.475321974326;6604.640936981569;6611.33886611335;9913.206943444364;10415.68752937413;10594.523246454082;10624.681259562225;10631.415272160106;10361.792764144826;10688.198385120992;10754.569817207224;10790.946045269724;10849.45752712377;7803.570803605856;8014.599270036359;8019.278264956182;8113.148119447373;8239.258466738022;8966.282697384064;9006.279497640042;9016.954915225382;9019.684311049345;9022.233110185707;7893.526388416713;8060.31487323584;8062.7581172564915;8121.066077400938;8127.3091787198755;7882.7241046563095;8017.679292828221;8033.1565185657;8068.7175948841505;8119.59402029908;6943.79168624942;6956.339147780953;7020.684069217;7027.648617568999;7028.753993610199;5326.813561525483;5332.733363331896;5340.919886201632;5349.545288650508;5396.1905714143195;5053.292539044463;5062.392512898476;5069.822556210515;5152.76812543444;5182.818601348935 01:39:29 INFO - PROCESS | 15132 | |4;prototype.html;334.70880334109313;348.2043530532732;351.24307118160357;354.9662782035706;356.75740496462396;5536.169574563817;5626.184203290521;5711.6287441316335;5767.33675627303;5777.746678795268;5643.250592316374;5654.575906806986;5679.57403194761;5679.858003549903;5683.829485115442;4444.622207112383;4446.310821822606;4475.30632751924;4475.955240447594;4488.573585509372;4379.167958087969;4409.4488188976375;4425.690201685883;4442.533533978934;4478.171538265415;4405.339199120125;4421.270490369086;4429.446319210098;4432.97783511082;4441.644668426518;4423.712458690207;4438.312061630452;4447.73313601185;4458.9331160032625;4459.55404459553;3633.6003039665616;3836.8848934532007;3951.5850835662127;3960.6435420811977;3968.6626636735914;5447.731361183298;5461.0716178249795;5479.589030822704;5508.421615730371;5517;5045.974770126126;5064.5441910228255;5067.695938243717;5081.390233172006;5086.72831792052;5598.888022239533;5939.554533410012;5951.196588460589;6006.309274433409;6010.57925945184;4160.564605211197;4161.875143745692;4173;4201.327787553977;4201.684873634459;6210.161628180228;6228.536293970913;6233.719482623293;6250.15622890913;6266.154069200645;4218.978905105516;4304.601004673494;4446.688731788809;4483.708558943658;4490.640748740093;4519.683622146418;4527.253003254492;4536.79584418702;4554.339620754972;4561.794719237642;5134.460881607452;5143.897122057538;5148.382194136728;5174.275601415805;5202.167653175474;5722.17028530869;5802.854928626818;5998.070299103646;6005.549583781234;6036.094585812076;1559.9766003509956;1574.8975716998148;1580.1467207707708;1583.817860946006;1585.6749366379865;1003.4631472162358;1021.1371391174446;1030.2685093583639;1030.6444276724667;1050.8791488978713;5120.2847046239185;5154.30416893722;5156.8856768724645;5177.585793136615;5186.5850731941355;5328.907573947332;5397.784088636489;5422.7017514036315;5424.159255315432;5430.402655707869;4899.58353539946;5121.8463446096675;5128.974355128201;5135.432283858071;5145.614078944094;2891.580720795473;2904.2448963269703;2911.743398865896;2919.3139612191117;2921.21127295629;5577.553795696334;5605.32736071674;5611.3907033228925;5646.491815736604;5670.234518340054;5210.270562121306;5514.779408823682;5561.30276815744;5633.380328163898;5681.971590142106;5605.439456054362;5630.40880707528;5637.943620563824;5667.291588551431;5669.291338582677;5156.922646160236;5311.681299122065;5412.945870541402;5454.945450545602;5466.699331536804;5250.73982244251;5266.394364648115;5306.548943339705;5317.441668624893;5392.164214546751;5576.219329293983;5578.442155784389;5588.524975377139;5611.214429979725;5651.491365777099;3933.685305175636;4115.259253334429;4145.2124096421585;4149.834006639821;4158.209940111369;5379.596530260168;5398.46015398457;5448.602614849454;5889.234399528205;5974;5872.794452194153;5941.762329506944;5945.435183657545;5973.581849270509;5993.580449368503;5842.620229685057;5888.849465535918;5890.410958904075;5893.941060589511;5901.970490147693;5596.916046259228;5827.1841942127285;5834.241548598655;5860.882782344414;5862.980565009109;5974.880502390015;6002.879942401215;6021.04968565391;6022.397760223943;6036.698165091816;5649.322081350264;5794.275715535558;5821.6525497838065;5822.534197264294;5825.650460972355 01:39:29 INFO - PROCESS | 15132 | |5;yui.html;757.9924200757991;804.8873157757915;819.5943008210936;846.8221673448576;856.7258477287271;15514.991525550831;16990.320387184496;17086.401975930847;17103.486895393144;17151.742723859137;15155.77266341003;15173.77239341408;15341.69316613667;15386.769198462032;15395.153266570362;650.440621065883;775.2789905387987;785.8781888807245;791.268077028749;791.7110254757001;794.6781553470825;796.6375299238862;797.720797720796;801.9639116239783;802.8273921106961;864.5201912938317;867.9392442529025;868.0321441592641;868.0668281597276;869.2784988459564;856.443311847298;859.5916939453804;859.8624220124781;860.5181098584812;861.1087524412235;625.2778041362234;627.5513008199114;628.4249911331126;628.6259675493075;628.7956414165369;16155.757663635055;16307.347706091741;16329.673406531922;16344.67310653792;16376.426825061066;15620.375184992587;15752.606184845356;15762.605934851606;15853.365865365371;16083.195840207944;12383.504659813596;12469.501219951191;12569.434375453127;12580.937095314557;12999.155054921495;3986.900327491807;4013.97993010036;4069.2878746219294;4118.814653340607;4192.266353388145;84237.57881210616;85610.57194714049;85720.14279857183;86801.56599216964;90000.54999725024;12155.392230388445;12352.38238088092;12452.688682783002;12735.29955852437;12939.158954667917;23368.298951031495;23738.88130559336;23791.643125353134;24079.27762167138;24470;8861.113888611088;8927.107289271022;9132.269418446509;9141.131592498701;9490.288228382899;4724.574788269004;4844.128056949712;4945.727984960789;5153.304303918998;5277.076511610453;3441.6558344165383;3544.8759293424605;3569.785812851237;3574.392353299945;3575.5888072871953;607.1621162795315;611.4313688269951;620.8075496596069;630.9053641953652;636.7675798333668;554.1632135475461;598.4823127994254;649.4155260265704;718.6155406857306;749.5277974875794;9948.502574871227;9952.004799520135;10367.985736219227;10539.789204215873;10561.419121948367;600.834770438133;605.1062649791004;631.1353445779312;718.482692461427;732.8937304090877;4938.827141050046;4958.281049247839;5005.199168133081;5021.49785021495;5129.256257842592;87811.56094219488;127139;133198.33400833127;133426.33286833504;134815;110390;110804.4459777712;111222.44388778004;111239;112029.47749441226;61209;63154.68422657949;79629.60185199037;97438.51280743552;101448;9611.807763844823;9710.902890971;9743.9025609743;9772.511374431107;9828.803423931624;48356.75821620869;54294.45705543052;55234.723826380614;55763;56790.716046419504;82054;84182.57908710417;85418;86960;88344;12930.418131183931;13017;13344.532941347006;13495.392707327997;13497.32513374347;13809.171449713049;13845.30773461343;13856.861431385558;14285.714285714435;14916.850831491547;12841.807372889602;13113.672158196121;13245.801312980506;13269.469221231042;13390.26353550564;13207.339633018502;13422.397248323508;13668.384922678304;13722;13870.4451821926;11194.722502220686;13224.537141200011;13722.176669399869;13924.51264205748;13998.090124141898;11681.649550513499;12048.397580121135;12203.511859525519;12355.405364873117;12479.188852724545;10446.843297350393;11130.666080017612;11233.775324493628;11251.887481125084;11397.829032564685 01:39:29 INFO - PROCESS | 15132 | __end_tp_report 01:39:29 INFO - PROCESS | 15132 | __start_cc_report 01:39:29 INFO - PROCESS | 15132 | _x_x_mozilla_cycle_collect,352 01:39:29 INFO - PROCESS | 15132 | __end_cc_report 01:39:29 INFO - PROCESS | 15132 | __startTimestamp1467362369024__endTimestamp 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | ------- Summary: start ------- 01:39:29 INFO - PROCESS | 15132 | Number of tests: 6 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | [#0] dojo.html Cycles:165 Average:5414.71 Median:5654.97 stddev:728.13 (12.9%) stddev-sans-first:707.10 01:39:29 INFO - PROCESS | 15132 | Values: 3087.2 3165.0 3168.3 3191.9 3199.5 5403.8 5451.4 5480.9 5541.9 5545.7 5326.9 5404.1 5464.9 5472.8 5496.1 4981.2 5009.1 5108.5 5155.1 5209.9 612.0 4736.9 4902.4 4919.6 5113.3 4953.4 4970.1 4997.2 5002.8 5008.7 4983.8 5011.9 5027.8 5033.5 5045.2 4941.8 4945.0 4991.5 5020.1 5032.6 5442.1 5485.8 5514.1 5568.9 5576.1 5667.8 5726.9 5892.9 5960.2 5977.0 5744.7 5814.0 5821.3 5842.0 5884.0 5367.4 5415.4 5436.8 5439.5 5448.8 5759.2 5844.2 5868.5 5894.4 5932.4 5632.7 5721.5 5721.7 5731.6 5789.7 5750.6 5761.6 5834.1 5839.6 5841.0 5570.9 5798.6 5807.1 5872.5 5883.8 5875.9 5924.3 5931.0 5933.5 5933.7 4450.9 4501.5 4502.2 4512.1 4545.6 3831.8 3838.6 3925.5 3929.5 3978.5 5592.9 5601.4 5630.0 5631.6 5643.8 5887.9 5952.3 6003.0 6005.8 6012.2 5454.9 5664.1 5702.7 5721.4 5781.5 5019.0 5025.2 5028.4 5035.8 5093.3 5807.9 6191.5 6225.0 6230.4 6233.3 5741.4 5757.0 5792.4 5798.0 5858.2 5987.3 5988.9 6013.3 6030.2 6033.8 5573.0 5674.4 5709.9 5711.6 5770.4 5903.1 5951.2 5967.3 5978.9 6040.5 5774.6 5790.6 5830.8 5834.9 5861.9 5525.6 5621.7 5658.6 5825.1 5836.8 5585.1 5607.5 5612.9 5655.0 5670.7 5747.0 5764.7 5769.1 5781.3 5808.6 5328.0 5527.1 5637.0 5642.5 5663.7 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | [#1] ext.html Cycles:180 Average:62394.87 Median:42678.41 stddev:130998.73 (306.9%) stddev-sans-first:131283.95 01:39:29 INFO - PROCESS | 15132 | Values: 560.5 587.7 596.7 622.4 644.7 40304.2 44216.6 44250.6 44261.0 44317.3 44344.8 44787.6 44835.8 44841.8 44889.3 8940.1 9071.8 9094.8 9102.8 9121.0 8905.5 8942.4 8977.2 9001.9 9024.6 9049.0 9063.0 9107.3 9120.2 9137.6 8990.3 9095.5 9101.1 9107.5 9109.0 8958.9 9001.1 9013.6 9033.3 9041.5 42370.0 42577.0 42846.0 43003.0 43042.4 2670.5 3323.2 3600.7 3747.8 4039.9 32666.5 32810.5 32850.7 33201.3 33246.5 4177.6 4381.0 4420.9 4429.8 4436.8 315215.0 317896.4 318304.0 318332.0 318625.0 37840.6 37966.6 37988.2 37994.8 37997.4 38445.0 38921.0 39038.4 39061.6 39070.0 14006.9 15641.5 16031.4 16049.7 16403.8 13419.7 13520.1 13536.3 13578.5 13633.0 8920.4 8932.1 8974.8 9008.3 9037.3 3455.6 3469.6 3482.4 3523.5 3539.3 985.3 1004.8 1036.7 1046.5 1106.5 33288.0 33542.2 33546.0 33926.7 34039.8 1138.2 1209.6 1215.5 1233.6 1242.6 17052.4 17650.2 17788.7 17852.3 17929.4 593806.0 599870.0 602497.0 606065.0 607377.0 60708.4 62266.7 62644.7 62724.7 62918.0 1374.2 1374.8 1376.7 1378.8 1391.3 30321.7 32756.3 32783.2 33120.0 33346.4 54185.0 54608.5 54616.7 54874.5 54915.0 505856.0 507096.0 509241.0 510955.0 515560.0 30137.2 30618.2 30746.0 30794.2 30800.1 49959.5 50405.7 50860.5 51577.7 52300.2 43392.8 44010.0 44365.8 44648.0 45695.5 42779.8 42993.8 43216.8 43459.8 44110.6 34328.8 38725.4 40589.6 43375.0 45178.8 35521.0 38402.4 38710.2 38937.2 39088.6 28165.4 28357.6 28574.4 28634.3 28898.0 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | [#2] jquery.html Cycles:180 Average:28974.42 Median:13478.53 stddev:79351.98 (588.7%) stddev-sans-first:79545.60 01:39:29 INFO - PROCESS | 15132 | Values: 411.1 412.0 412.6 413.7 432.2 18751.9 19888.1 20225.7 20489.6 20926.8 20070.8 20233.8 20620.0 20831.2 20910.2 5638.6 5800.2 5820.1 5844.6 5847.0 5537.9 5546.7 5560.8 5601.9 5660.3 5634.3 5643.7 5687.9 5716.9 5724.5 5678.5 5679.9 5731.1 5760.0 5762.3 5047.5 5154.7 5167.9 5191.9 5192.7 23763.9 23946.3 24530.9 24736.8 24787.6 2352.6 2426.2 2655.3 2659.2 3012.5 14918.6 14920.1 14986.3 15281.7 15368.8 1967.2 1984.8 1987.3 2039.4 2111.2 81251.6 82917.6 84688.6 85189.4 85264.0 10896.5 11397.4 11609.6 11669.8 11732.4 15676.6 15769.8 15794.0 15837.3 15854.4 8529.7 8676.4 8900.3 8918.7 8950.3 8528.8 8584.1 8625.5 8665.3 8749.6 6903.9 6988.4 7067.4 7138.5 7177.7 1996.3 2006.5 2036.9 2040.2 2083.2 958.2 970.3 1007.3 1017.2 1068.3 20113.6 20884.7 21049.2 21077.4 21159.2 1037.5 1061.9 1063.3 1071.9 1082.1 10596.9 11869.6 11947.7 11964.6 11975.5 473872.0 475006.0 486468.0 489544.0 489679.0 63762.0 84757.0 84840.0 84949.0 85049.6 998.7 1033.2 1060.3 1061.1 1068.2 17646.6 17880.2 18383.5 18437.0 18679.8 38923.0 39072.2 40049.6 40366.0 40440.2 52726.0 53843.5 54249.5 54466.7 54790.2 7932.9 9140.5 9248.9 9290.0 9626.3 10045.7 13831.9 14361.7 14550.5 14565.9 12167.9 12474.0 12521.6 12552.9 12629.4 12318.6 12406.1 12508.1 12524.6 12717.9 12618.7 12693.0 12928.6 12941.5 13060.7 8370.2 8370.5 8378.6 8570.5 8651.1 11230.9 12610.5 12679.2 12689.6 12892.5 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | [#3] mootools.html Cycles:180 Average:5940.30 Median:4986.05 stddev:3377.93 (67.7%) stddev-sans-first:3370.24 01:39:29 INFO - PROCESS | 15132 | Values: 1409.4 1467.7 1558.4 1785.2 1803.6 7767.7 8515.5 8791.2 9267.8 9279.2 8890.4 9020.8 9238.9 9250.4 9278.8 2353.7 2392.1 2395.3 2398.5 2398.7 2391.2 2446.4 2451.8 2453.4 2460.9 2412.0 2423.1 2425.5 2453.1 2454.8 2335.6 2337.7 2358.0 2369.8 2370.9 2311.0 2327.0 2335.9 2340.4 2343.1 9245.5 9265.2 9346.5 9367.3 9397.6 5431.7 5536.2 5541.5 5547.8 5550.1 3426.6 3452.4 3529.9 3545.4 3564.5 1116.9 1117.5 1204.2 1214.1 2174.2 11778.9 12128.3 12171.7 12228.9 12248.0 4434.6 4643.0 4663.9 4681.0 4700.0 9571.0 9584.0 9617.6 9621.8 9668.9 5388.0 5393.3 5404.5 5472.3 5516.7 4243.9 4918.8 5116.1 5122.1 5164.4 3860.5 3881.4 3980.5 3988.2 4024.3 1175.6 1179.0 1180.9 1181.5 1194.2 888.0 961.7 974.1 978.8 985.2 5887.9 5916.1 5956.5 6073.9 6217.7 451.3 452.9 459.8 462.9 463.4 4208.0 4455.3 4473.8 4495.7 4554.5 10641.0 11077.2 11416.0 11473.5 11643.8 11225.0 11378.9 11408.3 11431.1 11485.9 8075.0 8100.9 8256.6 8268.3 8287.3 6317.8 6431.2 6558.5 6604.6 6611.3 9913.2 10415.7 10594.5 10624.7 10631.4 10361.8 10688.2 10754.6 10790.9 10849.5 7803.6 8014.6 8019.3 8113.1 8239.3 8966.3 9006.3 9017.0 9019.7 9022.2 7893.5 8060.3 8062.8 8121.1 8127.3 7882.7 8017.7 8033.2 8068.7 8119.6 6943.8 6956.3 7020.7 7027.6 7028.8 5326.8 5332.7 5340.9 5349.5 5396.2 5053.3 5062.4 5069.8 5152.8 5182.8 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | [#4] prototype.html Cycles:180 Average:4821.14 Median:5314.56 stddev:1375.17 (25.9%) stddev-sans-first:1337.17 01:39:29 INFO - PROCESS | 15132 | Values: 334.7 348.2 351.2 355.0 356.8 5536.2 5626.2 5711.6 5767.3 5777.7 5643.3 5654.6 5679.6 5679.9 5683.8 4444.6 4446.3 4475.3 4476.0 4488.6 4379.2 4409.4 4425.7 4442.5 4478.2 4405.3 4421.3 4429.4 4433.0 4441.6 4423.7 4438.3 4447.7 4458.9 4459.6 3633.6 3836.9 3951.6 3960.6 3968.7 5447.7 5461.1 5479.6 5508.4 5517.0 5046.0 5064.5 5067.7 5081.4 5086.7 5598.9 5939.6 5951.2 6006.3 6010.6 4160.6 4161.9 4173.0 4201.3 4201.7 6210.2 6228.5 6233.7 6250.2 6266.2 4219.0 4304.6 4446.7 4483.7 4490.6 4519.7 4527.3 4536.8 4554.3 4561.8 5134.5 5143.9 5148.4 5174.3 5202.2 5722.2 5802.9 5998.1 6005.5 6036.1 1560.0 1574.9 1580.1 1583.8 1585.7 1003.5 1021.1 1030.3 1030.6 1050.9 5120.3 5154.3 5156.9 5177.6 5186.6 5328.9 5397.8 5422.7 5424.2 5430.4 4899.6 5121.8 5129.0 5135.4 5145.6 2891.6 2904.2 2911.7 2919.3 2921.2 5577.6 5605.3 5611.4 5646.5 5670.2 5210.3 5514.8 5561.3 5633.4 5682.0 5605.4 5630.4 5637.9 5667.3 5669.3 5156.9 5311.7 5412.9 5454.9 5466.7 5250.7 5266.4 5306.5 5317.4 5392.2 5576.2 5578.4 5588.5 5611.2 5651.5 3933.7 4115.3 4145.2 4149.8 4158.2 5379.6 5398.5 5448.6 5889.2 5974.0 5872.8 5941.8 5945.4 5973.6 5993.6 5842.6 5888.8 5890.4 5893.9 5902.0 5596.9 5827.2 5834.2 5860.9 5863.0 5974.9 6002.9 6021.0 6022.4 6036.7 5649.3 5794.3 5821.7 5822.5 5825.7 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - PROCESS | 15132 | [#5] yui.html Cycles:180 Average:22170.71 Median:4094.05 stddev:32634.01 (797.1%) stddev-sans-first:32685.95 01:39:29 INFO - PROCESS | 15132 | Values: 758.0 804.9 819.6 846.8 856.7 15515.0 16990.3 17086.4 17103.5 17151.7 15155.8 15173.8 15341.7 15386.8 15395.2 650.4 775.3 785.9 791.3 791.7 794.7 796.6 797.7 802.0 802.8 864.5 867.9 868.0 868.1 869.3 856.4 859.6 859.9 860.5 861.1 625.3 627.6 628.4 628.6 628.8 16155.8 16307.3 16329.7 16344.7 16376.4 15620.4 15752.6 15762.6 15853.4 16083.2 12383.5 12469.5 12569.4 12580.9 12999.2 3986.9 4014.0 4069.3 4118.8 4192.3 84237.6 85610.6 85720.1 86801.6 90000.5 12155.4 12352.4 12452.7 12735.3 12939.2 23368.3 23738.9 23791.6 24079.3 24470.0 8861.1 8927.1 9132.3 9141.1 9490.3 4724.6 4844.1 4945.7 5153.3 5277.1 3441.7 3544.9 3569.8 3574.4 3575.6 607.2 611.4 620.8 630.9 636.8 554.2 598.5 649.4 718.6 749.5 9948.5 9952.0 10368.0 10539.8 10561.4 600.8 605.1 631.1 718.5 732.9 4938.8 4958.3 5005.2 5021.5 5129.3 87811.6 127139.0 133198.3 133426.3 134815.0 110390.0 110804.4 111222.4 111239.0 112029.5 61209.0 63154.7 79629.6 97438.5 101448.0 9611.8 9710.9 9743.9 9772.5 9828.8 48356.8 54294.5 55234.7 55763.0 56790.7 82054.0 84182.6 85418.0 86960.0 88344.0 12930.4 13017.0 13344.5 13495.4 13497.3 13809.2 13845.3 13856.9 14285.7 14916.9 12841.8 13113.7 13245.8 13269.5 13390.3 13207.3 13422.4 13668.4 13722.0 13870.4 11194.7 13224.5 13722.2 13924.5 13998.1 11681.6 12048.4 12203.5 12355.4 12479.2 10446.8 11130.7 11233.8 11251.9 11397.8 01:39:29 INFO - PROCESS | 15132 | -------- Summary: end -------- 01:39:29 INFO - PROCESS | 15132 | 01:39:29 INFO - TEST-INFO | 15132: exit 0 01:39:29 INFO - TEST-OK | dromaeo_css | took 1144172ms 01:39:29 INFO - TEST-START | kraken 01:39:29 INFO - operating with platform_type : linux_ 01:39:29 INFO - Initialising browser for kraken test... 01:39:29 INFO - TEST-INFO | started process 15380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5r0spC/profile http://localhost:59726/getInfo.html) 01:39:39 INFO - PROCESS | 15380 | __metrics Screen width/height:1600/1200 01:39:39 INFO - PROCESS | 15380 | colorDepth:24 01:39:39 INFO - PROCESS | 15380 | Browser inner width/height: 1024/697 01:39:39 INFO - PROCESS | 15380 | __metrics 01:39:41 ERROR - PROCESS | 15380 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:39:42 INFO - TEST-INFO | 15380: exit 0 01:39:42 INFO - Browser initialized. 01:39:42 INFO - Running cycle 1/1 for kraken test... 01:39:42 INFO - TEST-INFO | started process 15503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5r0spC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:54 INFO - PROCESS | 15503 | RSS: Main: 168189952 01:39:54 INFO - PROCESS | 15503 | 01:39:56 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59726/tests/kraken/driver.html?testName=audio-beat-detection) 01:39:57 INFO - PROCESS | 15503 | RSS: Main: 173772800 01:39:57 INFO - PROCESS | 15503 | 01:40:00 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59726/tests/kraken/driver.html?testName=audio-dft) 01:40:01 INFO - PROCESS | 15503 | RSS: Main: 172990464 01:40:01 INFO - PROCESS | 15503 | 01:40:03 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59726/tests/kraken/driver.html?testName=audio-fft) 01:40:04 INFO - PROCESS | 15503 | RSS: Main: 167596032 01:40:04 INFO - PROCESS | 15503 | 01:40:06 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59726/tests/kraken/driver.html?testName=audio-oscillator) 01:40:07 INFO - PROCESS | 15503 | RSS: Main: 168620032 01:40:07 INFO - PROCESS | 15503 | 01:40:09 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:40:10 INFO - PROCESS | 15503 | RSS: Main: 168734720 01:40:10 INFO - PROCESS | 15503 | 01:40:13 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59726/tests/kraken/driver.html?testName=imaging-darkroom) 01:40:13 INFO - PROCESS | 15503 | RSS: Main: 167911424 01:40:13 INFO - PROCESS | 15503 | 01:40:17 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59726/tests/kraken/driver.html?testName=imaging-desaturate) 01:40:18 INFO - PROCESS | 15503 | RSS: Main: 166395904 01:40:18 INFO - PROCESS | 15503 | 01:40:20 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59726/tests/kraken/driver.html?testName=json-parse-financial) 01:40:21 INFO - PROCESS | 15503 | RSS: Main: 168013824 01:40:21 INFO - PROCESS | 15503 | 01:40:23 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:40:23 INFO - PROCESS | 15503 | RSS: Main: 168501248 01:40:23 INFO - PROCESS | 15503 | 01:40:25 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:40:26 INFO - PROCESS | 15503 | RSS: Main: 168976384 01:40:26 INFO - PROCESS | 15503 | 01:40:28 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:40:28 INFO - PROCESS | 15503 | RSS: Main: 169426944 01:40:28 INFO - PROCESS | 15503 | 01:40:31 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:40:32 INFO - PROCESS | 15503 | RSS: Main: 169693184 01:40:32 INFO - PROCESS | 15503 | 01:40:34 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:40:35 INFO - PROCESS | 15503 | RSS: Main: 169369600 01:40:35 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:59726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59726/tests/kraken/driver.html?testName=ai-astar) 01:40:37 INFO - PROCESS | 15503 | RSS: Main: 170262528 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | __start_tp_report 01:40:37 INFO - PROCESS | 15503 | _x_x_mozilla_page_load 01:40:37 INFO - PROCESS | 15503 | _x_x_mozilla_page_load_details 01:40:37 INFO - PROCESS | 15503 | |i|pagename|runs| 01:40:37 INFO - PROCESS | 15503 | |0;ai-astar;104;112;104;113;118;112;114;112;113;111 01:40:37 INFO - PROCESS | 15503 | |1;audio-beat-detection;152;120;146;173;125;147;139;119;178;123 01:40:37 INFO - PROCESS | 15503 | |2;audio-dft;162;162;161;161;165;165;174;164;161;161 01:40:37 INFO - PROCESS | 15503 | |3;audio-fft;74;75;75;161;76;76;81;75;160;76 01:40:37 INFO - PROCESS | 15503 | |4;audio-oscillator;83;84;146;85;85;86;144;84;85;141 01:40:37 INFO - PROCESS | 15503 | |5;imaging-gaussian-blur;117;117;118;117;118;117;120;122;118;117 01:40:37 INFO - PROCESS | 15503 | |6;imaging-darkroom;148;147;148;147;149;148;147;147;148;146 01:40:37 INFO - PROCESS | 15503 | |7;imaging-desaturate;95;97;96;96;96;96;96;96;96;96 01:40:37 INFO - PROCESS | 15503 | |8;json-parse-financial;61;54;56;58;54;55;59;56;55;55 01:40:37 INFO - PROCESS | 15503 | |9;json-stringify-tinderbox;62;66;62;62;62;64;61;61;64;63 01:40:37 INFO - PROCESS | 15503 | |10;stanford-crypto-aes;76;76;79;75;76;80;76;81;77;75 01:40:37 INFO - PROCESS | 15503 | |11;stanford-crypto-ccm;130;127;121;139;124;119;129;129;164;121 01:40:37 INFO - PROCESS | 15503 | |12;stanford-crypto-pbkdf2;157;158;157;160;160;159;155;154;160;159 01:40:37 INFO - PROCESS | 15503 | |13;stanford-crypto-sha256-iterative;63;63;66;65;64;66;63;63;64;63 01:40:37 INFO - PROCESS | 15503 | __end_tp_report 01:40:37 INFO - PROCESS | 15503 | __start_cc_report 01:40:37 INFO - PROCESS | 15503 | _x_x_mozilla_cycle_collect,931 01:40:37 INFO - PROCESS | 15503 | __end_cc_report 01:40:37 INFO - PROCESS | 15503 | __startTimestamp1467362437410__endTimestamp 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | ------- Summary: start ------- 01:40:37 INFO - PROCESS | 15503 | Number of tests: 14 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:4.30 (3.8%) stddev-sans-first:3.66 01:40:37 INFO - PROCESS | 15503 | Values: 104.0 112.0 104.0 113.0 118.0 112.0 114.0 112.0 113.0 111.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:146.50 stddev:21.26 (14.5%) stddev-sans-first:22.26 01:40:37 INFO - PROCESS | 15503 | Values: 152.0 120.0 146.0 173.0 125.0 147.0 139.0 119.0 178.0 123.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:4.01 (2.5%) stddev-sans-first:4.21 01:40:37 INFO - PROCESS | 15503 | Values: 162.0 162.0 161.0 161.0 165.0 165.0 174.0 164.0 161.0 161.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:35.68 (47.3%) stddev-sans-first:37.18 01:40:37 INFO - PROCESS | 15503 | Values: 74.0 75.0 75.0 161.0 76.0 76.0 81.0 75.0 160.0 76.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.50 stddev:28.58 (33.8%) stddev-sans-first:29.45 01:40:37 INFO - PROCESS | 15503 | Values: 83.0 84.0 146.0 85.0 85.0 86.0 144.0 84.0 85.0 141.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.66 (1.4%) stddev-sans-first:1.72 01:40:37 INFO - PROCESS | 15503 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 120.0 122.0 118.0 117.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 01:40:37 INFO - PROCESS | 15503 | Values: 148.0 147.0 148.0 147.0 149.0 148.0 147.0 147.0 148.0 146.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 01:40:37 INFO - PROCESS | 15503 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.31 (4.1%) stddev-sans-first:1.72 01:40:37 INFO - PROCESS | 15503 | Values: 61.0 54.0 56.0 58.0 54.0 55.0 59.0 56.0 55.0 55.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.50 stddev:1.57 (2.5%) stddev-sans-first:1.64 01:40:37 INFO - PROCESS | 15503 | Values: 62.0 66.0 62.0 62.0 62.0 64.0 61.0 61.0 64.0 63.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.50 stddev:2.13 (2.8%) stddev-sans-first:2.22 01:40:37 INFO - PROCESS | 15503 | Values: 76.0 76.0 79.0 75.0 76.0 80.0 76.0 81.0 77.0 75.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:129.00 stddev:13.19 (10.2%) stddev-sans-first:13.99 01:40:37 INFO - PROCESS | 15503 | Values: 130.0 127.0 121.0 139.0 124.0 119.0 129.0 129.0 164.0 121.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:159.00 stddev:2.13 (1.3%) stddev-sans-first:2.24 01:40:37 INFO - PROCESS | 15503 | Values: 157.0 158.0 157.0 160.0 160.0 159.0 155.0 154.0 160.0 159.0 01:40:37 INFO - PROCESS | 15503 | 01:40:37 INFO - PROCESS | 15503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.25 (1.9%) stddev-sans-first:1.27 01:40:37 INFO - PROCESS | 15503 | Values: 63.0 63.0 66.0 65.0 64.0 66.0 63.0 63.0 64.0 63.0 01:40:37 INFO - PROCESS | 15503 | -------- Summary: end -------- 01:40:37 INFO - PROCESS | 15503 | 01:40:38 INFO - TEST-INFO | 15503: exit 0 01:40:38 INFO - TEST-OK | kraken | took 68652ms 01:40:38 INFO - SUITE-END | took 1212s 01:40:39 INFO - Completed test suite (00:20:13) 01:40:39 INFO - javascript benchmark 01:40:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7379.039871218387, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.1664650544353, 3165.003024047425, 3168.3188114555364, 3191.9042428727116, 3199.472087105628, 5403.810866619664, 5451.37309209441, 5480.862978425542, 5541.861453463665, 5545.694986775736, 5326.946730532693, 5404.135338345865, 5464.9453505464935, 5472.808451704191, 5496.148097044955, 4981.178105612578, 5009.148444764399, 5108.4636113208135, 5155.072087024334, 5209.947900520984, 612.0453039719849, 4736.881577960561, 4902.362692849924, 4919.557239848413, 5113.258577506278, 4953.4303555091265, 4970.080535101018, 4997.225430058346, 5002.824901128443, 5008.699478031293, 4983.825566105205, 5011.874703132415, 5027.824026159104, 5033.521815427529, 5045.243213517965, 4941.827036053721, 4945.0, 4991.450940396553, 5020.071286811952, 5032.572231360339, 5442.12925931853, 5485.753141108659, 5514.0901751211, 5568.860778480571, 5576.079946808772, 5667.801626943078, 5726.885462290731, 5892.852678683024, 5960.225170727777, 5976.97011514944, 5744.655320680772, 5814.0, 5821.27234095738, 5841.970790146064, 5883.970580147115, 5367.436419176009, 5415.404305526428, 5436.755346009439, 5439.48324909133, 5448.809291674812, 5759.1649210865025, 5844.211031510777, 5868.530517558585, 5894.4400281974, 5932.436418540232, 5632.746526406321, 5721.5136713379, 5721.656700597978, 5731.598788084877, 5789.652620842763, 5750.568707346882, 5761.567882408753, 5834.095715164156, 5839.649621022667, 5841.036229022164, 5570.916436253459, 5798.594098413155, 5807.12893066035, 5872.500837428781, 5883.764649414061, 5875.882482350415, 5924.289085309791, 5931.0, 5933.465988061095, 5933.732982015819, 4450.933236001462, 4501.482329532146, 4502.189605870909, 4512.075024619945, 4545.636349092065, 3831.750936189139, 3838.596947320491, 3925.4896863407575, 3929.548101968253, 3978.462907507507, 5592.888142237132, 5601.383847776741, 5629.971850140723, 5631.605787594829, 5643.7742490299925, 5887.911681324698, 5952.315483719428, 6003.039513677791, 6005.789797357159, 6012.158297838306, 5454.863628409242, 5664.122061080539, 5702.7433765480655, 5721.370649228582, 5781.508571771446, 5019.0, 5025.246213067996, 5028.421731500851, 5035.823746168867, 5093.337866077386, 5807.941920580824, 6191.487452516942, 6225.00399936008, 6230.439260466489, 6233.283172435228, 5741.425857414225, 5756.971215143897, 5792.362840087502, 5797.971010144923, 5858.150568167506, 5987.311459182076, 5988.910166347596, 6013.308469525886, 6030.246219222598, 6033.75864965414, 5572.972135139298, 5674.375818659862, 5709.857253568528, 5711.5716321276905, 5770.394108618535, 5903.114532820111, 5951.16683664296, 5967.343592204941, 5978.940210597838, 6040.516758659384, 5774.624649397776, 5790.594658373873, 5830.766769329349, 5834.883302333845, 5861.9413805863105, 5525.557955363642, 5621.662700237999, 5658.632188907708, 5825.097109947965, 5836.824895253149, 5585.106382978704, 5607.467290607386, 5612.915806262828, 5654.971725141348, 5670.667393162521, 5746.965546201556, 5764.711764411846, 5769.134629805395, 5781.306243250837, 5808.593398462067, 5328.040952628409, 5527.115661494142, 5636.985342638364, 5642.463965923231, 5663.66018038919], "value": 5366.773461261885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.5319558168928, 587.7355190164426, 596.7463827873155, 622.4149299658319, 644.7098805537504, 40304.193916121694, 44216.557834421685, 44250.55749442505, 44261.0, 44317.33523997143, 44344.77827610866, 44787.552124478745, 44835.77582112085, 44841.775791121, 44889.32666010012, 8940.061293564164, 9071.773205669844, 9094.818103637956, 9102.772430689252, 9121.0, 8905.465672059665, 8942.374033817636, 8977.236934860544, 9001.909980900205, 9024.639014439448, 9049.0, 9062.954685226598, 9107.316951228651, 9120.17918387345, 9137.588808503633, 8990.28077753778, 9095.545222738903, 9101.135392137736, 9107.499087550183, 9108.954455227682, 8958.910410895873, 9001.144891235323, 9013.594388252544, 9033.322500812465, 9041.457512549268, 42370.0, 42577.0, 42846.0, 43003.0, 43042.35436468456, 2670.465906818644, 3323.21904352477, 3600.6939410150167, 3747.8126093695205, 4039.9192016159514, 32666.510002349984, 32810.50784238238, 32850.67149328524, 33201.33597328064, 33246.50130248048, 4177.644900183488, 4380.978095109536, 4420.867373978754, 4429.756363400012, 4436.800343984529, 315215.0, 317896.4105179482, 318304.0, 318332.0, 318625.0, 37840.62159378371, 37966.62033379631, 37988.24023519514, 37994.81002594969, 37997.43003854944, 38445.0, 38921.0, 39038.414423783666, 39061.60938390637, 39070.0, 14006.929965350311, 15641.530754077396, 16031.438899638457, 16049.679006419807, 16403.753943690856, 13419.731605368033, 13520.053596248365, 13536.25550594707, 13578.524751633842, 13633.045686801828, 8920.375573709778, 8932.106789321017, 8974.820503589892, 9008.279337653103, 9037.322200834964, 3455.605005288634, 3469.635688252697, 3482.425399809054, 3523.5067090607336, 3539.2744487380023, 985.3299756165876, 1004.8442491413697, 1036.7045392063226, 1046.49768111307, 1106.5348845258172, 33288.0, 33542.16144596356, 33546.0, 33926.66073339284, 34039.829800850835, 1138.2373809547623, 1209.5766481731323, 1215.4834195467067, 1233.586748439265, 1242.6147894152662, 17052.403165889384, 17650.205740741698, 17788.733169002477, 17852.285908563772, 17929.37247196342, 593806.0, 599870.0, 602497.0, 606065.0, 607377.0, 60708.392916071156, 62266.68866655638, 62644.686776565824, 62724.68637656783, 62918.0, 1374.2098293481288, 1374.8075269462283, 1376.6558360409897, 1378.7587172244816, 1391.3113009060378, 30321.696783031886, 32756.34487310288, 32783.180420489676, 33120.0, 33346.419324861956, 54185.0, 54608.45391546033, 54616.72691636675, 54874.451255486936, 54915.0, 505856.0, 507096.0, 509241.0, 510955.0, 515560.0, 30137.246568835955, 30618.234544136576, 30746.0, 30794.230144246572, 30800.075997720105, 49959.50040499549, 50405.74797126138, 50860.49139508558, 51577.742111289204, 52300.21549676682, 43392.78303608462, 44010.0, 44365.77817110894, 44648.0, 45695.54304456913, 42779.81857710523, 42993.78503107464, 43216.78391608022, 43459.78270108629, 44110.55889441064, 34328.82835585806, 38725.419118713806, 40589.59410405858, 43375.0, 45178.77410612926, 35521.0, 38402.42396364001, 38710.2257954845, 38937.2212555753, 39088.6091139085, 28165.43669126647, 28357.574636380883, 28574.427986542425, 28634.284142896595, 28898.0], "value": 19372.352626160973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.1345617475214, 411.9608637179468, 412.6265729514788, 413.74968144272697, 432.24141631436845, 18751.906240468794, 19888.105035273395, 20225.696614550794, 20489.590208195827, 20926.790732092675, 20070.799292007076, 20233.79766202341, 20620.0, 20831.166753329886, 20910.16359345628, 5638.605297629168, 5800.245968024172, 5820.126980952869, 5844.64932104073, 5846.9707651461895, 5537.889242215153, 5546.69493177875, 5560.805371811987, 5601.943980560183, 5660.3490598581075, 5634.267545219136, 5643.717814109299, 5687.857803554903, 5716.857078573027, 5724.542036637059, 5678.46054624812, 5679.886402271952, 5731.083026715747, 5760.049591817345, 5762.279715035621, 5047.49525047496, 5154.685555183404, 5167.870803229912, 5191.922121168185, 5192.71440070796, 23763.88118059416, 23946.28161155168, 24530.877345613157, 24736.752632473625, 24787.62818557705, 2352.635341522067, 2426.1872272788637, 2655.349439387343, 2659.2155314182364, 3012.487877060905, 14918.552443426715, 14920.104793712411, 14986.325615347336, 15281.694366112726, 15368.769468457982, 1967.1934506852122, 1984.82136607706, 1987.2746447546685, 2039.3881835449454, 2111.229401268541, 81251.5937420315, 82917.58541207315, 84688.57655711744, 85189.4443166706, 85264.0, 10896.455177241107, 11397.430128493543, 11609.593664221711, 11669.824952625717, 11732.354720490284, 15676.608084797972, 15769.842301576837, 15794.0, 15837.287322070535, 15854.365825367087, 8529.701460448854, 8676.436031657922, 8900.332475064397, 8918.687845925362, 8950.328725345626, 8528.84860543831, 8584.098669639723, 8625.482471051757, 8665.2634526066, 8749.56252187388, 6903.859803460943, 6988.44092472601, 7067.363937245673, 7138.535995160401, 7177.664163604393, 1996.3068323601512, 2006.5384961458653, 2036.867603605761, 2040.2349119080345, 2083.2083808152806, 958.152035448619, 970.315927271272, 1007.3452256033637, 1017.1760873692185, 1068.289587424354, 20113.592048556755, 20884.686729699068, 21049.158033678483, 21077.367678969655, 21159.15363385478, 1037.5382954585136, 1061.883192848786, 1063.3407287481657, 1071.8552995345685, 1082.1288862465633, 10596.89403105959, 11869.643910682693, 11947.701307467383, 11964.64106076819, 11975.52097916091, 473872.0, 475006.0, 486468.0, 489544.0, 489679.0, 63762.0, 84757.0, 84840.0, 84949.0, 85049.57475212708, 998.6704387552236, 1033.1631378583372, 1060.289605964006, 1061.1192710050639, 1068.1721665709138, 17646.558836029202, 17880.195391207686, 18383.540411489284, 18437.0, 18679.813201867808, 38923.0, 39072.21855562816, 40049.59950400459, 40366.0, 40440.1911961765, 52726.0, 53843.53877534721, 54249.45750542444, 54466.72766636142, 54790.17814732862, 7932.920670793218, 9140.451572905647, 9248.861267080865, 9289.953550232476, 9626.278029147981, 10045.69862904114, 13831.861681383058, 14361.712765744836, 14550.490732824725, 14565.85434145645, 12167.878321216675, 12474.0, 12521.624351269476, 12552.937235313764, 12629.431675574804, 12318.568850090203, 12406.069544783997, 12508.124431290087, 12524.624261272176, 12717.918976886698, 12618.684532886751, 12693.0, 12928.612141635766, 12941.482340706267, 13060.738785224432, 8370.16298370158, 8370.455920365157, 8378.622961966605, 8570.52862092566, 8651.134886511298, 11230.887691122984, 12610.49558017669, 12679.23924564529, 12689.555865544662, 12892.548760793326], "value": 9686.788730393182, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.422136923861, 1467.6624376393431, 1558.3922270314579, 1785.1609743420595, 1803.5941913069569, 7767.68929242831, 8515.53164575948, 8791.20879120879, 9267.814643707121, 9279.164875161234, 8890.42212256203, 9020.774480637987, 9238.86141707875, 9250.35247532673, 9278.814423711521, 2353.6940197774306, 2392.0670938334065, 2395.341281147681, 2398.4723360860585, 2398.724146723123, 2391.234804862445, 2446.376174075608, 2451.816113791464, 2453.4479742058074, 2460.9261722148362, 2412.0472413396787, 2423.127674037345, 2425.4906469641396, 2453.0555736041574, 2454.754524547549, 2335.5679199348174, 2337.6844126043106, 2358.0, 2369.763023697634, 2370.8696021718883, 2310.9716176301554, 2327.034280773477, 2335.94160145996, 2340.414896275931, 2343.0627748900406, 9245.537723113817, 9265.166135047879, 9346.532673366373, 9367.297452691007, 9397.577109030042, 5431.728413579344, 5536.197251398565, 5541.473560011793, 5547.77808887644, 5550.084236101038, 3426.6059403168706, 3452.378571857065, 3529.8941031769086, 3545.3795585772386, 3564.518789963374, 1116.8994790468896, 1117.5250518529592, 1204.2172587817902, 1214.1440284599337, 2174.206414658654, 11778.882211177865, 12128.27230366172, 12171.695707607292, 12228.938855305756, 12248.0, 4434.600885920218, 4642.9767851161205, 4663.854626871677, 4681.0, 4700.0, 9570.95214523923, 9584.0, 9617.56720947545, 9621.759456013655, 9668.9033109668, 5387.973060134753, 5393.27190829233, 5404.540614047772, 5472.288602481652, 5516.724163791875, 4243.936340954888, 4918.803247870117, 5116.104681680691, 5122.129238029544, 5164.3802743671, 3860.4788353571907, 3881.4177873319227, 3980.5024371953505, 3988.202359528106, 4024.3158663027357, 1175.5767923547517, 1179.0, 1180.8819118088122, 1181.4565299962114, 1194.2476239968764, 887.9644814207488, 961.6826447272523, 974.1232890398697, 978.7895602445366, 985.1576901749045, 5887.852803679943, 5916.1421593868645, 5956.523478121827, 6073.908891366633, 6217.6891155442045, 451.28921947931485, 452.87093178443985, 459.7632219407008, 462.85651448051215, 463.3952691737315, 4208.0, 4455.287154055336, 4473.843415480507, 4495.707778994355, 4554.544545545486, 10641.0, 11077.224594278485, 11416.0, 11473.483693233824, 11643.767124657628, 11225.0, 11378.943105284587, 11408.258463199865, 11431.085513158927, 11485.942570287096, 8074.959625201836, 8100.918990810134, 8256.628451719687, 8268.338532917352, 8287.295579875657, 6317.842053948504, 6431.228252609717, 6558.475321974326, 6604.640936981569, 6611.33886611335, 9913.206943444364, 10415.68752937413, 10594.523246454082, 10624.681259562225, 10631.415272160106, 10361.792764144826, 10688.198385120992, 10754.569817207224, 10790.946045269724, 10849.45752712377, 7803.570803605856, 8014.599270036359, 8019.278264956182, 8113.148119447373, 8239.258466738022, 8966.282697384064, 9006.279497640042, 9016.954915225382, 9019.684311049345, 9022.233110185707, 7893.526388416713, 8060.31487323584, 8062.7581172564915, 8121.066077400938, 8127.3091787198755, 7882.7241046563095, 8017.679292828221, 8033.1565185657, 8068.7175948841505, 8119.59402029908, 6943.79168624942, 6956.339147780953, 7020.684069217, 7027.648617568999, 7028.753993610199, 5326.813561525483, 5332.733363331896, 5340.919886201632, 5349.545288650508, 5396.1905714143195, 5053.292539044463, 5062.392512898476, 5069.822556210515, 5152.76812543444, 5182.818601348935], "value": 4677.046062999473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.70880334109313, 348.2043530532732, 351.24307118160357, 354.9662782035706, 356.75740496462396, 5536.169574563817, 5626.184203290521, 5711.6287441316335, 5767.33675627303, 5777.746678795268, 5643.250592316374, 5654.575906806986, 5679.57403194761, 5679.858003549903, 5683.829485115442, 4444.622207112383, 4446.310821822606, 4475.30632751924, 4475.955240447594, 4488.573585509372, 4379.167958087969, 4409.4488188976375, 4425.690201685883, 4442.533533978934, 4478.171538265415, 4405.339199120125, 4421.270490369086, 4429.446319210098, 4432.97783511082, 4441.644668426518, 4423.712458690207, 4438.312061630452, 4447.73313601185, 4458.9331160032625, 4459.55404459553, 3633.6003039665616, 3836.8848934532007, 3951.5850835662127, 3960.6435420811977, 3968.6626636735914, 5447.731361183298, 5461.0716178249795, 5479.589030822704, 5508.421615730371, 5517.0, 5045.974770126126, 5064.5441910228255, 5067.695938243717, 5081.390233172006, 5086.72831792052, 5598.888022239533, 5939.554533410012, 5951.196588460589, 6006.309274433409, 6010.57925945184, 4160.564605211197, 4161.875143745692, 4173.0, 4201.327787553977, 4201.684873634459, 6210.161628180228, 6228.536293970913, 6233.719482623293, 6250.15622890913, 6266.154069200645, 4218.978905105516, 4304.601004673494, 4446.688731788809, 4483.708558943658, 4490.640748740093, 4519.683622146418, 4527.253003254492, 4536.79584418702, 4554.339620754972, 4561.794719237642, 5134.460881607452, 5143.897122057538, 5148.382194136728, 5174.275601415805, 5202.167653175474, 5722.17028530869, 5802.854928626818, 5998.070299103646, 6005.549583781234, 6036.094585812076, 1559.9766003509956, 1574.8975716998148, 1580.1467207707708, 1583.817860946006, 1585.6749366379865, 1003.4631472162358, 1021.1371391174446, 1030.2685093583639, 1030.6444276724667, 1050.8791488978713, 5120.2847046239185, 5154.30416893722, 5156.8856768724645, 5177.585793136615, 5186.5850731941355, 5328.907573947332, 5397.784088636489, 5422.7017514036315, 5424.159255315432, 5430.402655707869, 4899.58353539946, 5121.8463446096675, 5128.974355128201, 5135.432283858071, 5145.614078944094, 2891.580720795473, 2904.2448963269703, 2911.743398865896, 2919.3139612191117, 2921.21127295629, 5577.553795696334, 5605.32736071674, 5611.3907033228925, 5646.491815736604, 5670.234518340054, 5210.270562121306, 5514.779408823682, 5561.30276815744, 5633.380328163898, 5681.971590142106, 5605.439456054362, 5630.40880707528, 5637.943620563824, 5667.291588551431, 5669.291338582677, 5156.922646160236, 5311.681299122065, 5412.945870541402, 5454.945450545602, 5466.699331536804, 5250.73982244251, 5266.394364648115, 5306.548943339705, 5317.441668624893, 5392.164214546751, 5576.219329293983, 5578.442155784389, 5588.524975377139, 5611.214429979725, 5651.491365777099, 3933.685305175636, 4115.259253334429, 4145.2124096421585, 4149.834006639821, 4158.209940111369, 5379.596530260168, 5398.46015398457, 5448.602614849454, 5889.234399528205, 5974.0, 5872.794452194153, 5941.762329506944, 5945.435183657545, 5973.581849270509, 5993.580449368503, 5842.620229685057, 5888.849465535918, 5890.410958904075, 5893.941060589511, 5901.970490147693, 5596.916046259228, 5827.1841942127285, 5834.241548598655, 5860.882782344414, 5862.980565009109, 5974.880502390015, 6002.879942401215, 6021.04968565391, 6022.397760223943, 6036.698165091816, 5649.322081350264, 5794.275715535558, 5821.6525497838065, 5822.534197264294, 5825.650460972355], "value": 4389.232294563248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.9924200757991, 804.8873157757915, 819.5943008210936, 846.8221673448576, 856.7258477287271, 15514.991525550831, 16990.320387184496, 17086.401975930847, 17103.486895393144, 17151.742723859137, 15155.77266341003, 15173.77239341408, 15341.69316613667, 15386.769198462032, 15395.153266570362, 650.440621065883, 775.2789905387987, 785.8781888807245, 791.268077028749, 791.7110254757001, 794.6781553470825, 796.6375299238862, 797.720797720796, 801.9639116239783, 802.8273921106961, 864.5201912938317, 867.9392442529025, 868.0321441592641, 868.0668281597276, 869.2784988459564, 856.443311847298, 859.5916939453804, 859.8624220124781, 860.5181098584812, 861.1087524412235, 625.2778041362234, 627.5513008199114, 628.4249911331126, 628.6259675493075, 628.7956414165369, 16155.757663635055, 16307.347706091741, 16329.673406531922, 16344.67310653792, 16376.426825061066, 15620.375184992587, 15752.606184845356, 15762.605934851606, 15853.365865365371, 16083.195840207944, 12383.504659813596, 12469.501219951191, 12569.434375453127, 12580.937095314557, 12999.155054921495, 3986.900327491807, 4013.97993010036, 4069.2878746219294, 4118.814653340607, 4192.266353388145, 84237.57881210616, 85610.57194714049, 85720.14279857183, 86801.56599216964, 90000.54999725024, 12155.392230388445, 12352.38238088092, 12452.688682783002, 12735.29955852437, 12939.158954667917, 23368.298951031495, 23738.88130559336, 23791.643125353134, 24079.27762167138, 24470.0, 8861.113888611088, 8927.107289271022, 9132.269418446509, 9141.131592498701, 9490.288228382899, 4724.574788269004, 4844.128056949712, 4945.727984960789, 5153.304303918998, 5277.076511610453, 3441.6558344165383, 3544.8759293424605, 3569.785812851237, 3574.392353299945, 3575.5888072871953, 607.1621162795315, 611.4313688269951, 620.8075496596069, 630.9053641953652, 636.7675798333668, 554.1632135475461, 598.4823127994254, 649.4155260265704, 718.6155406857306, 749.5277974875794, 9948.502574871227, 9952.004799520135, 10367.985736219227, 10539.789204215873, 10561.419121948367, 600.834770438133, 605.1062649791004, 631.1353445779312, 718.482692461427, 732.8937304090877, 4938.827141050046, 4958.281049247839, 5005.199168133081, 5021.49785021495, 5129.256257842592, 87811.56094219488, 127139.0, 133198.33400833127, 133426.33286833504, 134815.0, 110390.0, 110804.4459777712, 111222.44388778004, 111239.0, 112029.47749441226, 61209.0, 63154.68422657949, 79629.60185199037, 97438.51280743552, 101448.0, 9611.807763844823, 9710.902890971, 9743.9025609743, 9772.511374431107, 9828.803423931624, 48356.75821620869, 54294.45705543052, 55234.723826380614, 55763.0, 56790.716046419504, 82054.0, 84182.57908710417, 85418.0, 86960.0, 88344.0, 12930.418131183931, 13017.0, 13344.532941347006, 13495.392707327997, 13497.32513374347, 13809.171449713049, 13845.30773461343, 13856.861431385558, 14285.714285714435, 14916.850831491547, 12841.807372889602, 13113.672158196121, 13245.801312980506, 13269.469221231042, 13390.26353550564, 13207.339633018502, 13422.397248323508, 13668.384922678304, 13722.0, 13870.4451821926, 11194.722502220686, 13224.537141200011, 13722.176669399869, 13924.51264205748, 13998.090124141898, 11681.649550513499, 12048.397580121135, 12203.511859525519, 12355.405364873117, 12479.188852724545, 10446.843297350393, 11130.666080017612, 11233.775324493628, 11251.887481125084, 11397.829032564685], "value": 7807.6621579852, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 104.0, 113.0, 118.0, 112.0, 114.0, 112.0, 113.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 146.0, 173.0, 125.0, 147.0, 139.0, 119.0, 178.0, 123.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 165.0, 165.0, 174.0, 164.0, 161.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 161.0, 76.0, 76.0, 81.0, 75.0, 160.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 146.0, 85.0, 85.0, 86.0, 144.0, 84.0, 85.0, 141.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 120.0, 122.0, 118.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 149.0, 148.0, 147.0, 147.0, 148.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 56.0, 58.0, 54.0, 55.0, 59.0, 56.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 62.0, 62.0, 62.0, 64.0, 61.0, 61.0, 64.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 75.0, 76.0, 80.0, 76.0, 81.0, 77.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 121.0, 139.0, 124.0, 119.0, 129.0, 129.0, 164.0, 121.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 157.0, 160.0, 160.0, 159.0, 155.0, 154.0, 160.0, 159.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 65.0, 64.0, 66.0, 63.0, 63.0, 64.0, 63.0], "value": 64.0, "unit": "score"}]}]} 01:40:39 INFO - Return code: 0 01:40:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:40:39 ERROR - # TBPL SUCCESS # 01:40:39 INFO - Running post-action listener: _resource_record_post_action 01:40:39 INFO - ##### 01:40:39 INFO - ##### Finished run-tests step (success) 01:40:39 INFO - ##### 01:40:39 INFO - Running post-run listener: _resource_record_post_run 01:40:39 INFO - Total resource usage - Wall time: 1236s; CPU: 14.0%; Read bytes: 4096; Write bytes: 552628224; Read time: 652; Write time: 4177232 01:40:39 INFO - TinderboxPrint: CPU usage
13.7% 01:40:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 652 01:40:39 INFO - TinderboxPrint: I/O write bytes / time
552,628,224 / 4,177,232 01:40:39 INFO - TinderboxPrint: CPU idle
8,507.3 (86.3%) 01:40:39 INFO - TinderboxPrint: CPU user
1,219.3 (12.4%) 01:40:39 INFO - TinderboxPrint: Swap in / out
0 / 0 01:40:39 INFO - install - Wall time: 23s; CPU: 22.0%; Read bytes: 0; Write bytes: 166518784; Read time: 0; Write time: 1329976 01:40:39 INFO - run-tests - Wall time: 1214s; CPU: 14.0%; Read bytes: 0; Write bytes: 384008192; Read time: 0; Write time: 2816784 01:40:39 INFO - Running post-run listener: _upload_blobber_files 01:40:39 INFO - Blob upload gear active. 01:40:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:40:39 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 01:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:40:40 INFO - (blobuploader) - INFO - Open directory for files ... 01:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:43 INFO - (blobuploader) - INFO - Done attempting. 01:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:44 INFO - (blobuploader) - INFO - Done attempting. 01:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:45 INFO - (blobuploader) - INFO - Done attempting. 01:40:45 INFO - (blobuploader) - INFO - Iteration through files over. 01:40:45 INFO - Return code: 0 01:40:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:40:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:40:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be60698ccdb5fb1196867b2052f121bdacfba0afa73c4247522902de09ba0b824107321011d3a0a3635b1e7398aca5aa32aa0d3bb487e1e7722eecdc9581afff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ada058ea0e215cfc40a5609573c9ec17ae5f6b274e7bb05e26d3d40338ff1c4e455076c176f2470ebaa2f323b0609675f10b0f4b10dcd739d307e649b2182d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51c71c57c4a8ed59e8a42c6435c55738d721c3b577080be1a57736201fb65a3047428b014ca120e4c08e02dc724139c83963ef8e153e05b2e1beba4c580dfc85"} 01:40:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:40:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:40:45 INFO - Contents: 01:40:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be60698ccdb5fb1196867b2052f121bdacfba0afa73c4247522902de09ba0b824107321011d3a0a3635b1e7398aca5aa32aa0d3bb487e1e7722eecdc9581afff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ada058ea0e215cfc40a5609573c9ec17ae5f6b274e7bb05e26d3d40338ff1c4e455076c176f2470ebaa2f323b0609675f10b0f4b10dcd739d307e649b2182d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51c71c57c4a8ed59e8a42c6435c55738d721c3b577080be1a57736201fb65a3047428b014ca120e4c08e02dc724139c83963ef8e153e05b2e1beba4c580dfc85"} 01:40:45 INFO - Running post-run listener: copy_logs_to_upload_dir 01:40:45 INFO - Copying logs to upload dir... 01:40:45 INFO - mkdir: /builds/slave/test/build/upload/logs 01:40:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.053525 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-07-01 01:40:44.765574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 01:40:44.770033) ========= 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=33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be60698ccdb5fb1196867b2052f121bdacfba0afa73c4247522902de09ba0b824107321011d3a0a3635b1e7398aca5aa32aa0d3bb487e1e7722eecdc9581afff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ada058ea0e215cfc40a5609573c9ec17ae5f6b274e7bb05e26d3d40338ff1c4e455076c176f2470ebaa2f323b0609675f10b0f4b10dcd739d307e649b2182d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51c71c57c4a8ed59e8a42c6435c55738d721c3b577080be1a57736201fb65a3047428b014ca120e4c08e02dc724139c83963ef8e153e05b2e1beba4c580dfc85"} build_url:https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/QzxT8guWTA-nUq7ZEIW9eQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be60698ccdb5fb1196867b2052f121bdacfba0afa73c4247522902de09ba0b824107321011d3a0a3635b1e7398aca5aa32aa0d3bb487e1e7722eecdc9581afff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ada058ea0e215cfc40a5609573c9ec17ae5f6b274e7bb05e26d3d40338ff1c4e455076c176f2470ebaa2f323b0609675f10b0f4b10dcd739d307e649b2182d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51c71c57c4a8ed59e8a42c6435c55738d721c3b577080be1a57736201fb65a3047428b014ca120e4c08e02dc724139c83963ef8e153e05b2e1beba4c580dfc85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 01:40:44.799827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:40:44.800181) ========= 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=33d5923976266a1c518c4bf7000001ab-1467351591.25572-236091560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:40:44.887967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 01:40:44.888338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 01:40:44.888733) ========= ========= Total master_lag: 0.19 =========