builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1467635432.84 results: success (0) buildid: 20160704040324 builduid: c19e637935174a778c8bdfda1f635856 revision: 4191df8e4b8e1e2dd0593132dac25915f987f797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:32.842432) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:32.843069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:32.843379) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:32.903786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:32.904133) ========= 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=7de08804244eb36560b44971000001c3-1467631106.260491-1974037232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 05:30:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 231M=0s 2016-07-04 05:30:33 (231 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192375 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:33.138096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:33.138507) ========= 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=7de08804244eb36560b44971000001c3-1467631106.260491-1974037232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.089339 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:33.240230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 05:30:33.240587) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4191df8e4b8e1e2dd0593132dac25915f987f797 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4191df8e4b8e1e2dd0593132dac25915f987f797 --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=7de08804244eb36560b44971000001c3-1467631106.260491-1974037232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 05:30:33,338 truncating revision to first 12 chars 2016-07-04 05:30:33,338 Setting DEBUG logging. 2016-07-04 05:30:33,338 attempt 1/10 2016-07-04 05:30:33,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4191df8e4b8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 05:30:34,717 unpacking tar archive at: mozilla-central-4191df8e4b8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.719920 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 05:30:34.974474) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:34.974795) ========= script_repo_revision: 4191df8e4b8e1e2dd0593132dac25915f987f797 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:34.975240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:34.975520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 05:30:34.987985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-04 05:30:34.988393) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1467631106.260491-1974037232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:30:35 INFO - MultiFileLogger online at 20160704 05:30:35 in /builds/slave/test 05:30:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:30:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:30:35 INFO - {'append_to_log': False, 05:30:35 INFO - 'base_work_dir': '/builds/slave/test', 05:30:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:30:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:30:35 INFO - 'branch': 'Firefox-Non-PGO', 05:30:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:35 INFO - 'config_files': ('talos/linux_config.py',), 05:30:35 INFO - 'default_actions': ('clobber', 05:30:35 INFO - 'read-buildbot-config', 05:30:35 INFO - 'download-and-extract', 05:30:35 INFO - 'populate-webroot', 05:30:35 INFO - 'create-virtualenv', 05:30:35 INFO - 'install', 05:30:35 INFO - 'run-tests'), 05:30:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:35 INFO - 'download_minidump_stackwalk': True, 05:30:35 INFO - 'download_symbols': 'ondemand', 05:30:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:35 INFO - 'installer_path': 'installer.exe', 05:30:35 INFO - 'log_level': 'info', 05:30:35 INFO - 'log_name': 'talos', 05:30:35 INFO - 'log_to_console': True, 05:30:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:30:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:30:35 INFO - 'opt_config_files': (), 05:30:35 INFO - 'pip_index': False, 05:30:35 INFO - 'sps_profile': False, 05:30:35 INFO - 'sps_profile_interval': 0, 05:30:35 INFO - 'suite': 'dromaeojs-e10s', 05:30:35 INFO - 'system_bits': '32', 05:30:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:35 INFO - 'title': 'talos-linux64-ix-003', 05:30:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:35 INFO - 'use_talos_json': True, 05:30:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:30:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:35 INFO - 'work_dir': 'build'} 05:30:35 INFO - ##### 05:30:35 INFO - ##### Running clobber step. 05:30:35 INFO - ##### 05:30:35 INFO - Running pre-action listener: _resource_record_pre_action 05:30:35 INFO - Running main action method: clobber 05:30:35 INFO - rmtree: /builds/slave/test/build 05:30:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:30:36 INFO - Running post-action listener: _resource_record_post_action 05:30:36 INFO - ##### 05:30:36 INFO - ##### Finished clobber step (success) 05:30:36 INFO - ##### 05:30:36 INFO - ##### 05:30:36 INFO - ##### Running read-buildbot-config step. 05:30:36 INFO - ##### 05:30:36 INFO - Running pre-action listener: _resource_record_pre_action 05:30:36 INFO - Running main action method: read_buildbot_config 05:30:36 INFO - Using buildbot properties: 05:30:36 INFO - { 05:30:36 INFO - "project": "", 05:30:36 INFO - "product": "firefox", 05:30:36 INFO - "script_repo_revision": "production", 05:30:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:30:36 INFO - "repository": "", 05:30:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:30:36 INFO - "buildid": "20160704040324", 05:30:36 INFO - "pgo_build": "False", 05:30:36 INFO - "basedir": "/builds/slave/test", 05:30:36 INFO - "buildnumber": 388, 05:30:36 INFO - "slavename": "talos-linux64-ix-003", 05:30:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:30:36 INFO - "platform": "ubuntu64_hw", 05:30:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:30:36 INFO - "branch": "mozilla-central", 05:30:36 INFO - "repo_path": "mozilla-central", 05:30:36 INFO - "revision": "4191df8e4b8e1e2dd0593132dac25915f987f797", 05:30:36 INFO - "stage_platform": "linux64", 05:30:36 INFO - "builduid": "c19e637935174a778c8bdfda1f635856", 05:30:36 INFO - "slavebuilddir": "test" 05:30:36 INFO - } 05:30:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:30:36 INFO - Running post-action listener: _resource_record_post_action 05:30:36 INFO - ##### 05:30:36 INFO - ##### Finished read-buildbot-config step (success) 05:30:36 INFO - ##### 05:30:36 INFO - ##### 05:30:36 INFO - ##### Running download-and-extract step. 05:30:36 INFO - ##### 05:30:36 INFO - Running pre-action listener: _resource_record_pre_action 05:30:36 INFO - Running main action method: download_and_extract 05:30:36 INFO - mkdir: /builds/slave/test/build/tests 05:30:36 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')]} 05:30:36 INFO - https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:41 INFO - Downloaded 1361 bytes. 05:30:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:30:41 INFO - Using the following test package requirements: 05:30:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:30:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:30:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'jsshell-linux-x86_64.zip'], 05:30:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:30:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:30:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:30:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:30:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:30:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:41 INFO - https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:49 INFO - Downloaded 22709818 bytes. 05:30:49 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'] 05:30:49 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 05:30:50 INFO - Return code: 0 05:30:50 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 05:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:50 INFO - https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:30:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:51 INFO - Downloaded 22709818 bytes. 05:30:51 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'] 05:30:51 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 05:30:53 INFO - Return code: 0 05:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:53 INFO - https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:54 INFO - Downloaded 14403333 bytes. 05:30:54 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'] 05:30:54 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 05:30:54 INFO - Return code: 0 05:30:54 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')]} 05:30:54 INFO - https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:30:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1k80cCjQvy56Q_EuG2fzw/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 05:30:55 INFO - Downloaded 56478760 bytes. 05:30:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:55 INFO - mkdir: /builds/slave/test/properties 05:30:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:55 INFO - Contents: 05:30:55 INFO - build_url:https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:30:56 INFO - Running post-action listener: _resource_record_post_action 05:30:56 INFO - Running post-action listener: set_extra_try_arguments 05:30:56 INFO - ##### 05:30:56 INFO - ##### Finished download-and-extract step (success) 05:30:56 INFO - ##### 05:30:56 INFO - ##### 05:30:56 INFO - ##### Running populate-webroot step. 05:30:56 INFO - ##### 05:30:56 INFO - Running pre-action listener: _resource_record_pre_action 05:30:56 INFO - Running main action method: populate_webroot 05:30:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:56 INFO - '--tppagecycles', 05:30:56 INFO - '7'], 05:30:56 INFO - 'tests': ['tsvgm']}}, 05:30:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['damp', 'tps']}, 05:30:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'tests': ['damp', 'tps']}, 05:30:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['dromaeo_dom']}, 05:30:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['basic_compositor_video']}, 05:30:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:30:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['a11yr', 05:30:56 INFO - 'ts_paint', 05:30:56 INFO - 'tpaint', 05:30:56 INFO - 'sessionrestore', 05:30:56 INFO - 'sessionrestore_no_auto_restore', 05:30:56 INFO - 'tabpaint']}, 05:30:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:56 INFO - 'ts_paint', 05:30:56 INFO - 'tpaint', 05:30:56 INFO - 'sessionrestore', 05:30:56 INFO - 'sessionrestore_no_auto_restore', 05:30:56 INFO - 'tabpaint']}, 05:30:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:30:56 INFO - 'ts_paint', 05:30:56 INFO - 'tpaint', 05:30:56 INFO - 'sessionrestore', 05:30:56 INFO - 'sessionrestore_no_auto_restore', 05:30:56 INFO - 'tabpaint']}, 05:30:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:30:56 INFO - 'ts_paint', 05:30:56 INFO - 'tpaint', 05:30:56 INFO - 'sessionrestore', 05:30:56 INFO - 'sessionrestore_no_auto_restore', 05:30:56 INFO - 'tabpaint']}, 05:30:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['a11yr', 05:30:56 INFO - 'ts_paint', 05:30:56 INFO - 'tpaint', 05:30:56 INFO - 'sessionrestore', 05:30:56 INFO - 'sessionrestore_no_auto_restore', 05:30:56 INFO - 'tabpaint']}, 05:30:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['a11yr', 05:30:56 INFO - 'ts_paint', 05:30:56 INFO - 'tpaint', 05:30:56 INFO - 'sessionrestore', 05:30:56 INFO - 'sessionrestore_no_auto_restore', 05:30:56 INFO - 'tabpaint']}, 05:30:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['tsvgx', 05:30:56 INFO - 'tsvgr_opacity', 05:30:56 INFO - 'tart', 05:30:56 INFO - 'tscrollx', 05:30:56 INFO - 'cart']}, 05:30:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:56 INFO - 'tsvgr_opacity', 05:30:56 INFO - 'tart', 05:30:56 INFO - 'tscrollx', 05:30:56 INFO - 'cart']}, 05:30:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'talos_options': ['--disable-e10s'], 05:30:56 INFO - 'tests': ['tp5o']}, 05:30:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'tests': ['tp5o']}, 05:30:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'talos_options': ['--disable-e10s', 05:30:56 INFO - '--xperf_path', 05:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:56 INFO - 'tests': ['tp5n']}, 05:30:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:56 INFO - 'talos_options': ['--xperf_path', 05:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:56 INFO - 'tests': ['tp5n']}}, 05:30:56 INFO - 'talos.zip': {'path': '', 05:30:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:56 INFO - Running post-action listener: _resource_record_post_action 05:30:56 INFO - ##### 05:30:56 INFO - ##### Finished populate-webroot step (success) 05:30:56 INFO - ##### 05:30:56 INFO - ##### 05:30:56 INFO - ##### Running create-virtualenv step. 05:30:56 INFO - ##### 05:30:56 INFO - Running pre-action listener: _resource_record_pre_action 05:30:56 INFO - Running main action method: create_virtualenv 05:30:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:56 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 05:30:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:56 INFO - Using real prefix '/usr' 05:30:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:59 INFO - Installing pip.................done. 05:30:59 INFO - Return code: 0 05:30:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:59 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')]} 05:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 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')]} 05:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:30:59 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 05:30:59 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 05:30:59 INFO - Using env: {'DISPLAY': ':0', 05:30:59 INFO - 'HOME': '/home/cltbld', 05:30:59 INFO - 'LANG': 'en_US.UTF-8', 05:30:59 INFO - 'LANGUAGE': 'en_US:en', 05:30:59 INFO - 'LOGNAME': 'cltbld', 05:30:59 INFO - 'MAIL': '/var/mail/cltbld', 05:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:59 INFO - 'MOZ_NO_REMOTE': '1', 05:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:59 INFO - 'NO_EM_RESTART': '1', 05:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:59 INFO - 'PWD': '/builds/slave/test', 05:30:59 INFO - 'SHELL': '/bin/bash', 05:30:59 INFO - 'SHLVL': '1', 05:30:59 INFO - 'TERM': 'linux', 05:30:59 INFO - 'TMOUT': '86400', 05:30:59 INFO - 'USER': 'cltbld', 05:30:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:59 INFO - '_': '/tools/buildbot/bin/python'} 05:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:59 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 05:30:59 INFO - Cleaning up... 05:30:59 INFO - Return code: 0 05:30:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:59 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')]} 05:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 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')]} 05:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:30:59 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 05:30:59 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 05:30:59 INFO - Using env: {'DISPLAY': ':0', 05:30:59 INFO - 'HOME': '/home/cltbld', 05:30:59 INFO - 'LANG': 'en_US.UTF-8', 05:30:59 INFO - 'LANGUAGE': 'en_US:en', 05:30:59 INFO - 'LOGNAME': 'cltbld', 05:30:59 INFO - 'MAIL': '/var/mail/cltbld', 05:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:59 INFO - 'MOZ_NO_REMOTE': '1', 05:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:59 INFO - 'NO_EM_RESTART': '1', 05:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:59 INFO - 'PWD': '/builds/slave/test', 05:30:59 INFO - 'SHELL': '/bin/bash', 05:30:59 INFO - 'SHLVL': '1', 05:30:59 INFO - 'TERM': 'linux', 05:30:59 INFO - 'TMOUT': '86400', 05:30:59 INFO - 'USER': 'cltbld', 05:30:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:59 INFO - '_': '/tools/buildbot/bin/python'} 05:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:00 INFO - Downloading/unpacking psutil>=3.1.1 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:02 INFO - Installing collected packages: psutil 05:31:02 INFO - Running setup.py install for psutil 05:31:02 INFO - building 'psutil._psutil_linux' extension 05:31:02 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 05:31:03 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 05:31:03 INFO - building 'psutil._psutil_posix' extension 05:31:03 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 05:31:03 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 05:31:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:03 INFO - Successfully installed psutil 05:31:03 INFO - Cleaning up... 05:31:03 INFO - Return code: 0 05:31:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:03 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:31:03 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 05:31:03 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 05:31:03 INFO - Using env: {'DISPLAY': ':0', 05:31:03 INFO - 'HOME': '/home/cltbld', 05:31:03 INFO - 'LANG': 'en_US.UTF-8', 05:31:03 INFO - 'LANGUAGE': 'en_US:en', 05:31:03 INFO - 'LOGNAME': 'cltbld', 05:31:03 INFO - 'MAIL': '/var/mail/cltbld', 05:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:03 INFO - 'MOZ_NO_REMOTE': '1', 05:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:03 INFO - 'NO_EM_RESTART': '1', 05:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:03 INFO - 'PWD': '/builds/slave/test', 05:31:03 INFO - 'SHELL': '/bin/bash', 05:31:03 INFO - 'SHLVL': '1', 05:31:03 INFO - 'TERM': 'linux', 05:31:03 INFO - 'TMOUT': '86400', 05:31:03 INFO - 'USER': 'cltbld', 05:31:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:03 INFO - '_': '/tools/buildbot/bin/python'} 05:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:31:03 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 05:31:03 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 05:31:03 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 05:31:03 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 05:31:03 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 05:31:03 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 05:31:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:31:05 INFO - Installing collected packages: mozsystemmonitor 05:31:05 INFO - Running setup.py install for mozsystemmonitor 05:31:05 INFO - Successfully installed mozsystemmonitor 05:31:05 INFO - Cleaning up... 05:31:06 INFO - Return code: 0 05:31:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:31:06 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')]} 05:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:06 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')]} 05:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:06 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:31:06 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 05:31:06 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 05:31:06 INFO - Using env: {'DISPLAY': ':0', 05:31:06 INFO - 'HOME': '/home/cltbld', 05:31:06 INFO - 'LANG': 'en_US.UTF-8', 05:31:06 INFO - 'LANGUAGE': 'en_US:en', 05:31:06 INFO - 'LOGNAME': 'cltbld', 05:31:06 INFO - 'MAIL': '/var/mail/cltbld', 05:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:06 INFO - 'MOZ_NO_REMOTE': '1', 05:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:06 INFO - 'NO_EM_RESTART': '1', 05:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:06 INFO - 'PWD': '/builds/slave/test', 05:31:06 INFO - 'SHELL': '/bin/bash', 05:31:06 INFO - 'SHLVL': '1', 05:31:06 INFO - 'TERM': 'linux', 05:31:06 INFO - 'TMOUT': '86400', 05:31:06 INFO - 'USER': 'cltbld', 05:31:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:06 INFO - '_': '/tools/buildbot/bin/python'} 05:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:31:08 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 05:31:08 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 05:31:08 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 05:31:08 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 05:31:08 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 05:31:08 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 05:31:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:08 INFO - warning: no files found matching '*.txt' 05:31:08 INFO - no previously-included directories found matching 'build' 05:31:08 INFO - no previously-included directories found matching 'dist' 05:31:08 INFO - no previously-included directories found matching '.git*' 05:31:08 INFO - Installing collected packages: jsonschema, functools32 05:31:08 INFO - Running setup.py install for functools32 05:31:08 INFO - warning: no files found matching '*.txt' 05:31:08 INFO - no previously-included directories found matching 'build' 05:31:08 INFO - no previously-included directories found matching 'dist' 05:31:08 INFO - no previously-included directories found matching '.git*' 05:31:08 INFO - Successfully installed jsonschema functools32 05:31:08 INFO - Cleaning up... 05:31:08 INFO - Return code: 0 05:31:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:08 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:31:08 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 05:31:08 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 05:31:08 INFO - Using env: {'DISPLAY': ':0', 05:31:08 INFO - 'HOME': '/home/cltbld', 05:31:08 INFO - 'LANG': 'en_US.UTF-8', 05:31:08 INFO - 'LANGUAGE': 'en_US:en', 05:31:08 INFO - 'LOGNAME': 'cltbld', 05:31:08 INFO - 'MAIL': '/var/mail/cltbld', 05:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:08 INFO - 'MOZ_NO_REMOTE': '1', 05:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:08 INFO - 'NO_EM_RESTART': '1', 05:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:08 INFO - 'PWD': '/builds/slave/test', 05:31:08 INFO - 'SHELL': '/bin/bash', 05:31:08 INFO - 'SHLVL': '1', 05:31:08 INFO - 'TERM': 'linux', 05:31:08 INFO - 'TMOUT': '86400', 05:31:08 INFO - 'USER': 'cltbld', 05:31:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:08 INFO - '_': '/tools/buildbot/bin/python'} 05:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:08 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 05:31:08 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 05:31:08 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 05:31:08 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 05:31:08 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 05:31:08 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 05:31:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:31:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:11 INFO - Downloading docopt-0.6.1.tar.gz 05:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:31:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:31:11 INFO - Running setup.py install for blobuploader 05:31:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:31:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:31:11 INFO - Running setup.py install for requests 05:31:11 INFO - Running setup.py install for docopt 05:31:12 INFO - Successfully installed blobuploader requests docopt 05:31:12 INFO - Cleaning up... 05:31:12 INFO - Return code: 0 05:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:12 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:31:12 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 05:31:12 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 05:31:12 INFO - Using env: {'DISPLAY': ':0', 05:31:12 INFO - 'HOME': '/home/cltbld', 05:31:12 INFO - 'LANG': 'en_US.UTF-8', 05:31:12 INFO - 'LANGUAGE': 'en_US:en', 05:31:12 INFO - 'LOGNAME': 'cltbld', 05:31:12 INFO - 'MAIL': '/var/mail/cltbld', 05:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:12 INFO - 'MOZ_NO_REMOTE': '1', 05:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:12 INFO - 'NO_EM_RESTART': '1', 05:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:12 INFO - 'PWD': '/builds/slave/test', 05:31:12 INFO - 'SHELL': '/bin/bash', 05:31:12 INFO - 'SHLVL': '1', 05:31:12 INFO - 'TERM': 'linux', 05:31:12 INFO - 'TMOUT': '86400', 05:31:12 INFO - 'USER': 'cltbld', 05:31:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:12 INFO - '_': '/tools/buildbot/bin/python'} 05:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:12 INFO - Running setup.py (path:/tmp/pip-z7SeOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:12 INFO - Running setup.py (path:/tmp/pip-iFbblW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:12 INFO - Running setup.py (path:/tmp/pip-RpZNI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:12 INFO - Running setup.py (path:/tmp/pip-DEywZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:12 INFO - Running setup.py (path:/tmp/pip-dj4Wbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:12 INFO - Running setup.py (path:/tmp/pip-YZsjQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:12 INFO - Running setup.py (path:/tmp/pip-EWDom4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:12 INFO - Running setup.py (path:/tmp/pip-CaZrHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:12 INFO - Running setup.py (path:/tmp/pip-dvsi_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:12 INFO - Running setup.py (path:/tmp/pip-oxqkhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:13 INFO - Running setup.py (path:/tmp/pip-pcPAKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:13 INFO - Running setup.py (path:/tmp/pip-wbKab1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:13 INFO - Running setup.py (path:/tmp/pip-5JyQRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:13 INFO - Running setup.py (path:/tmp/pip-cWP5em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:13 INFO - Running setup.py (path:/tmp/pip-TX4emz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:13 INFO - Running setup.py (path:/tmp/pip-DcgXkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:13 INFO - Running setup.py (path:/tmp/pip-wdkQmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:13 INFO - Running setup.py install for manifestparser 05:31:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:31:13 INFO - Running setup.py install for mozcrash 05:31:13 INFO - Running setup.py install for mozdebug 05:31:13 INFO - Running setup.py install for mozdevice 05:31:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:31:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:31:13 INFO - Running setup.py install for mozfile 05:31:14 INFO - Running setup.py install for mozhttpd 05:31:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Running setup.py install for mozinfo 05:31:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Running setup.py install for mozInstall 05:31:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Running setup.py install for mozleak 05:31:14 INFO - Running setup.py install for mozlog 05:31:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Running setup.py install for moznetwork 05:31:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Running setup.py install for mozprocess 05:31:14 INFO - Running setup.py install for mozprofile 05:31:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Running setup.py install for mozrunner 05:31:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:31:14 INFO - Running setup.py install for mozscreenshot 05:31:15 INFO - Running setup.py install for moztest 05:31:15 INFO - Running setup.py install for mozversion 05:31:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:31:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:15 INFO - Cleaning up... 05:31:15 INFO - Return code: 0 05:31:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:15 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:31:15 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 05:31:15 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 05:31:15 INFO - Using env: {'DISPLAY': ':0', 05:31:15 INFO - 'HOME': '/home/cltbld', 05:31:15 INFO - 'LANG': 'en_US.UTF-8', 05:31:15 INFO - 'LANGUAGE': 'en_US:en', 05:31:15 INFO - 'LOGNAME': 'cltbld', 05:31:15 INFO - 'MAIL': '/var/mail/cltbld', 05:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:15 INFO - 'MOZ_NO_REMOTE': '1', 05:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:15 INFO - 'NO_EM_RESTART': '1', 05:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:15 INFO - 'PWD': '/builds/slave/test', 05:31:15 INFO - 'SHELL': '/bin/bash', 05:31:15 INFO - 'SHLVL': '1', 05:31:15 INFO - 'TERM': 'linux', 05:31:15 INFO - 'TMOUT': '86400', 05:31:15 INFO - 'USER': 'cltbld', 05:31:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:15 INFO - '_': '/tools/buildbot/bin/python'} 05:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:15 INFO - Running setup.py (path:/tmp/pip-Bk2gJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:15 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)) 05:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:15 INFO - Running setup.py (path:/tmp/pip-qaUf7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:15 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)) 05:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:15 INFO - Running setup.py (path:/tmp/pip-cVPWMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:15 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)) 05:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:15 INFO - Running setup.py (path:/tmp/pip-0MXvYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:15 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)) 05:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:15 INFO - Running setup.py (path:/tmp/pip-1GY37b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:15 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)) 05:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:15 INFO - Running setup.py (path:/tmp/pip-lb3IE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:15 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)) 05:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:15 INFO - Running setup.py (path:/tmp/pip-U7rriN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:16 INFO - Running setup.py (path:/tmp/pip-foywZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:16 INFO - Running setup.py (path:/tmp/pip-_rQuxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:16 INFO - Running setup.py (path:/tmp/pip-pZ9slE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:16 INFO - Running setup.py (path:/tmp/pip-oU039M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:16 INFO - Running setup.py (path:/tmp/pip-KmGefu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:16 INFO - Running setup.py (path:/tmp/pip-pw2cir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:16 INFO - Running setup.py (path:/tmp/pip-Oq5Fda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:16 INFO - Running setup.py (path:/tmp/pip-62_g87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:16 INFO - Running setup.py (path:/tmp/pip-p2GF9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:16 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)) 05:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:16 INFO - Running setup.py (path:/tmp/pip-Vp30kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:16 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)) 05:31:16 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)) 05:31:16 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)) 05:31:16 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)) 05:31:16 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)) 05:31:16 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)) 05:31:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:18 INFO - Downloading blessings-1.6.tar.gz 05:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:18 INFO - Installing collected packages: blessings 05:31:18 INFO - Running setup.py install for blessings 05:31:18 INFO - Successfully installed blessings 05:31:18 INFO - Cleaning up... 05:31:18 INFO - Return code: 0 05:31:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:31:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:19 INFO - Reading from file tmpfile_stdout 05:31:19 INFO - Current package versions: 05:31:19 INFO - argparse == 1.2.1 05:31:19 INFO - blessings == 1.6 05:31:19 INFO - blobuploader == 1.2.4 05:31:19 INFO - docopt == 0.6.1 05:31:19 INFO - functools32 == 3.2.3-2 05:31:19 INFO - jsonschema == 2.5.1 05:31:19 INFO - manifestparser == 1.1 05:31:19 INFO - mozInstall == 1.12 05:31:19 INFO - mozcrash == 0.17 05:31:19 INFO - mozdebug == 0.1 05:31:19 INFO - mozdevice == 0.48 05:31:19 INFO - mozfile == 1.2 05:31:19 INFO - mozhttpd == 0.7 05:31:19 INFO - mozinfo == 0.9 05:31:19 INFO - mozleak == 0.1 05:31:19 INFO - mozlog == 3.2 05:31:19 INFO - moznetwork == 0.27 05:31:19 INFO - mozprocess == 0.22 05:31:19 INFO - mozprofile == 0.28 05:31:19 INFO - mozrunner == 6.11 05:31:19 INFO - mozscreenshot == 0.1 05:31:19 INFO - mozsystemmonitor == 0.3 05:31:19 INFO - moztest == 0.7 05:31:19 INFO - mozversion == 1.4 05:31:19 INFO - psutil == 3.1.1 05:31:19 INFO - requests == 1.2.3 05:31:19 INFO - wsgiref == 0.1.2 05:31:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:19 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:31:19 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 05:31:19 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 05:31:19 INFO - Using env: {'DISPLAY': ':0', 05:31:19 INFO - 'HOME': '/home/cltbld', 05:31:19 INFO - 'LANG': 'en_US.UTF-8', 05:31:19 INFO - 'LANGUAGE': 'en_US:en', 05:31:19 INFO - 'LOGNAME': 'cltbld', 05:31:19 INFO - 'MAIL': '/var/mail/cltbld', 05:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:19 INFO - 'MOZ_NO_REMOTE': '1', 05:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:19 INFO - 'NO_EM_RESTART': '1', 05:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:19 INFO - 'PWD': '/builds/slave/test', 05:31:19 INFO - 'SHELL': '/bin/bash', 05:31:19 INFO - 'SHLVL': '1', 05:31:19 INFO - 'TERM': 'linux', 05:31:19 INFO - 'TMOUT': '86400', 05:31:19 INFO - 'USER': 'cltbld', 05:31:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:19 INFO - '_': '/tools/buildbot/bin/python'} 05:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 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)) 05:31:19 INFO - Cleaning up... 05:31:19 INFO - Return code: 0 05:31:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2943400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, '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': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', '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 05:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:31:19 INFO - Using env: {'DISPLAY': ':0', 05:31:19 INFO - 'HOME': '/home/cltbld', 05:31:19 INFO - 'LANG': 'en_US.UTF-8', 05:31:19 INFO - 'LANGUAGE': 'en_US:en', 05:31:19 INFO - 'LOGNAME': 'cltbld', 05:31:19 INFO - 'MAIL': '/var/mail/cltbld', 05:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:19 INFO - 'MOZ_NO_REMOTE': '1', 05:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:19 INFO - 'NO_EM_RESTART': '1', 05:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:19 INFO - 'PWD': '/builds/slave/test', 05:31:19 INFO - 'SHELL': '/bin/bash', 05:31:19 INFO - 'SHLVL': '1', 05:31:19 INFO - 'TERM': 'linux', 05:31:19 INFO - 'TMOUT': '86400', 05:31:19 INFO - 'USER': 'cltbld', 05:31:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:19 INFO - '_': '/tools/buildbot/bin/python'} 05:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:31:19 INFO - Cleaning up... 05:31:19 INFO - Return code: 0 05:31:19 INFO - Running post-action listener: _resource_record_post_action 05:31:19 INFO - Running post-action listener: _start_resource_monitoring 05:31:19 INFO - Starting resource monitoring. 05:31:19 INFO - ##### 05:31:19 INFO - ##### Finished create-virtualenv step (success) 05:31:19 INFO - ##### 05:31:19 INFO - ##### 05:31:19 INFO - ##### Running install step. 05:31:19 INFO - ##### 05:31:19 INFO - Running pre-action listener: _resource_record_pre_action 05:31:19 INFO - Running main action method: install 05:31:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:19 INFO - Reading from file tmpfile_stdout 05:31:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:31:19 INFO - Reading from file tmpfile_stdout 05:31:19 INFO - Output received: 05:31:19 INFO - Usage: mozinstall [options] installer 05:31:19 INFO - Options: 05:31:19 INFO - -h, --help show this help message and exit 05:31:19 INFO - -d DEST, --destination=DEST 05:31:19 INFO - Directory to install application into. [default: 05:31:19 INFO - "/builds/slave/test"] 05:31:19 INFO - --app=APP Application being installed. [default: firefox] 05:31:19 INFO - mkdir: /builds/slave/test/build/application 05:31:19 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'] 05:31:19 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 05:31:36 INFO - Reading from file tmpfile_stdout 05:31:36 INFO - Output received: 05:31:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:31:36 INFO - Running post-action listener: _resource_record_post_action 05:31:36 INFO - ##### 05:31:36 INFO - ##### Finished install step (success) 05:31:36 INFO - ##### 05:31:36 INFO - ##### 05:31:36 INFO - ##### Running run-tests step. 05:31:36 INFO - ##### 05:31:36 INFO - Running pre-action listener: _resource_record_pre_action 05:31:36 INFO - Running main action method: run_tests 05:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:31:36 INFO - Python 2.7.3 05:31:36 INFO - Return code: 0 05:31:36 INFO - grabbing minidump binary from tooltool 05:31:36 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')]} 05:31:36 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 0x29d2570>, '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 0x29d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:31:36 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 05:31:36 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 05:31:36 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 05:31:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:36 INFO - Return code: 0 05:31:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:31:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:31:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:31:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:31:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 05:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 05:31:36 INFO - Using env: {'DISPLAY': ':0', 05:31:36 INFO - 'HOME': '/home/cltbld', 05:31:36 INFO - 'LANG': 'en_US.UTF-8', 05:31:36 INFO - 'LANGUAGE': 'en_US:en', 05:31:36 INFO - 'LOGNAME': 'cltbld', 05:31:36 INFO - 'MAIL': '/var/mail/cltbld', 05:31:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:31:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:36 INFO - 'MOZ_NO_REMOTE': '1', 05:31:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:36 INFO - 'NO_EM_RESTART': '1', 05:31:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:36 INFO - 'PWD': '/builds/slave/test', 05:31:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:31:36 INFO - 'SHELL': '/bin/bash', 05:31:36 INFO - 'SHLVL': '1', 05:31:36 INFO - 'TERM': 'linux', 05:31:36 INFO - 'TMOUT': '86400', 05:31:36 INFO - 'USER': 'cltbld', 05:31:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467631106.260491-1974037232', 05:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:36 INFO - '_': '/tools/buildbot/bin/python'} 05:31:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 05:31:36 INFO - mozversion application_buildid: 20160704040324 05:31:36 INFO - mozversion application_changeset: 4191df8e4b8e1e2dd0593132dac25915f987f797 05:31:36 INFO - mozversion application_display_name: Nightly 05:31:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:36 INFO - mozversion application_name: Firefox 05:31:36 INFO - mozversion application_remotingname: firefox 05:31:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:31:36 INFO - mozversion application_vendor: Mozilla 05:31:36 INFO - mozversion application_version: 50.0a1 05:31:36 INFO - mozversion platform_buildid: 20160704040324 05:31:36 INFO - mozversion platform_changeset: 4191df8e4b8e1e2dd0593132dac25915f987f797 05:31:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:31:36 INFO - mozversion platform_version: 50.0a1 05:31:36 INFO - using testdate: 1467635496 05:31:36 INFO - actual date: 1467635496 05:31:36 INFO - starting webserver on 'localhost:47499' 05:31:36 INFO - SUITE-START | Running 2 tests 05:31:36 INFO - TEST-START | dromaeo_css 05:31:36 INFO - operating with platform_type : linux_ 05:31:36 INFO - Initialising browser for dromaeo_css test... 05:31:36 INFO - TEST-INFO | started process 3336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLZDl3/profile http://localhost:47499/getInfo.html) 05:31:43 INFO - PROCESS | 3336 | __metrics Screen width/height:1600/1200 05:31:43 INFO - PROCESS | 3336 | colorDepth:24 05:31:43 INFO - PROCESS | 3336 | Browser inner width/height: 1024/697 05:31:43 INFO - PROCESS | 3336 | __metrics 05:31:44 ERROR - PROCESS | 3336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:31:44 INFO - TEST-INFO | 3336: exit 0 05:31:44 INFO - Browser initialized. 05:31:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:44 INFO - TEST-INFO | started process 3454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLZDl3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:56 INFO - PROCESS | 3454 | RSS: Main: 170274816 05:31:56 INFO - PROCESS | 3454 | 05:32:46 INFO - PROCESS | 3454 | 1467635566553 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] 05:34:58 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:47499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47499/tests/dromaeo/cssquery-ext.html) 05:35:00 INFO - PROCESS | 3454 | RSS: Main: 172089344 05:35:00 INFO - PROCESS | 3454 | 05:38:02 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:47499/tests/dromaeo/cssquery-ext.html (next: http://localhost:47499/tests/dromaeo/cssquery-jquery.html) 05:38:02 INFO - PROCESS | 3454 | RSS: Main: 169148416 05:38:02 INFO - PROCESS | 3454 | 05:41:04 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:47499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47499/tests/dromaeo/cssquery-mootools.html) 05:41:05 INFO - PROCESS | 3454 | RSS: Main: 172384256 05:41:05 INFO - PROCESS | 3454 | 05:44:07 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:47499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47499/tests/dromaeo/cssquery-prototype.html) 05:44:07 INFO - PROCESS | 3454 | RSS: Main: 168144896 05:44:07 INFO - PROCESS | 3454 | 05:47:10 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:47499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47499/tests/dromaeo/cssquery-yui.html) 05:47:11 INFO - PROCESS | 3454 | RSS: Main: 169668608 05:47:11 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:47499/tests/dromaeo/cssquery-yui.html (next: http://localhost:47499/tests/dromaeo/cssquery-dojo.html) 05:50:14 INFO - PROCESS | 3454 | RSS: Main: 171335680 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | __start_tp_report 05:50:14 INFO - PROCESS | 3454 | _x_x_mozilla_page_load 05:50:14 INFO - PROCESS | 3454 | _x_x_mozilla_page_load_details 05:50:14 INFO - PROCESS | 3454 | |i|pagename|runs| 05:50:14 INFO - PROCESS | 3454 | |0;dojo.html;2601.7658410743034;2668.839869607824;2669.906553270636;2686.5567181415054;2686.9328266793327;4760.166970780113;4781.043791241753;4807.08665353583;4839.831485235083;4905.460399356077;4704.85885423437;4788.497207793183;4814.398200224972;4817.494163112867;4825.927611085836;4385.846495372654;4420.806720182919;4536.047430039695;4542.8864278392975;4545.909081818361;579.5780825403212;4350.934735978963;4365.36702178184;4384.451943507046;4477.70894891831;4401.823927042915;4425.269830477967;4435.445569303837;4437.778111094464;4487;4445.155420470101;4448.510663826976;4455.643548516111;4459.843905463325;4485.529019452975;4301.956980430187;4389.363542286383;4405.074934263776;4409.316555933835;4413.558644135593;4747.121782470254;4839.661223714342;4848.490908454632;4866.075445665312;4876.390451193601;5089.3638295213095;5214.582833373321;5217.060929032773;5218.843434696965;5275.419703832576;5138.229265610151;5176.482351764831;5182.689038657692;5184.974075129638;5239.109351410231;4795.328653988445;4820.614350851958;4825.662203645781;4826.903461930812;4874.975625121887;5258.342707161605;5301.443348448434;5315.229291752674;5330.733463326818;5335.413104558495;5107.412647545506;5108.974455127701;5117.667351622133;5123.538881500608;5171.3018742469285;5212.635115541952;5217.530422262014;5220.895582088337;5227.60792940531;5255.421903590602;4993.775280112331;5092.898142037138;5141.948580514222;5147.510986456281;5172.456892026358;5130.076586214443;5136.921246538269;5137.33214682089;5158.0199762045095;5168.819091331786;4383.211022016004;4390.626796722315;4391.626711729538;4413.470383553994;4442.622377097919;3786.8674596388996;3787.5265591801026;3794.734368594172;3807.695384369244;3847.461355410245;4454.710443821141;4462.843800466968;4474.239379305526;4475.172093162711;4562.08758248345;5236.266922630834;5241.764120614582;5248.921266181011;5250.448702886219;5253.632245742761;4411.625011873963;4460.286354183315;4473.843415480443;4484.730916145042;4488.214562451558;4628.699134556243;4646.581807637329;4649.907001859944;4663.580277775017;4679.344891715163;4720.433547974265;4858.125537403302;4887.584555312838;4900.5099490052135;4936.456989731127;5148.30497882796;5165.509276618715;5223.112070948024;5235.397929238034;5239;4851.58761505276;4868.829590964299;4871.439784424695;4876;4910.9017819642695;5049.015441988777;5138.97430512845;5146.099432599205;5148.58811295088;5149.253358263106;5168.043911876315;5206.036883176473;5217.791288348575;5228.660137091077;5279.868003299948;5063.417706963746;5076.11168045598;5076.847694569169;5101.540861322499;5134.743262836918;4881.877953051202;5034.144195486703;5047.974760126176;5059.5952323814745;5066.214736715815;4947.233178857283;4961.330220420341;5000.949990500194;5004.549590536869;5055.1153548128195;5130.384353877409;5131.153359695609;5146.459621739664;5155.9742201288755;5167.044096842096;4861.6596838220985;4974.054929563371;5004.84985450437;5016.824411145738;5027.371578552681 05:50:14 INFO - PROCESS | 3454 | |1;ext.html;578.5140481995123;585.8037557418262;588.5997521685252;591.0956236957455;625.5402279324699;36077.63922360776;40406.191876162535;40418.39372409416;40497.99999999996;40572.79713601428;40761.79619101908;41027.38458923119;41087.38368924461;41192.58807411925;41261.381079283834;7790.922090779076;7916.604169791516;7916.643751031189;7921.841563168733;7947.841043179133;7785.961070194641;7906.407019473534;7917.208279172094;7927.643256053491;7959.044914610255;7940.483868548555;7943.5631040292765;7943.960280198591;7944.682212711514;7961.164077771838;7905;7907.169747176578;7956.045274567031;7962.641681124334;7965.840683186333;7801.0638723352995;7845.490043147177;7892.644830982562;7899.723509677134;7904.09102953162;38667.80666096652;38883.8055809722;38972.80513597414;38981.805090974645;39070.41394379087;2997.250687328168;3126.234072652192;3366.4613661814237;3687.46531752897;3813.0848596336677;30249.395012099856;30476;30508.8474557628;30698.53952190719;31670.36659266802;3594.856205751767;3604.8017359045243;3646.3254297954963;3649.105969037603;3715.442683597455;264156;264370;265123;266156;266656;31943.84028079891;33009.66990330066;52611.473885261425;53150.734246329295;53156.46843531515;33994.660053399646;33997.66002339994;34040;34133.658663413546;34275.82862085674;13216.73566528664;13339.533116340881;13371.264580448169;13383.866161338457;13399.933000334935;10476.0571548561;10530.31552949056;10549.525271362807;10556.261061725605;10578.365298082139;7839.25527074927;7936.206379362017;7959.124496305518;8041.798955026171;8046.114927357986;3110.3934732726902;3135.745701719285;3141.246100935759;3161.3993341265545;3174.444472217399;842.0695131879307;870.2081106193334;923.6351641101727;966.227018385303;1031.1235449867702;28203.71796282052;29048;29264.853675731913;29430.852845736063;29463.558046629318;874.8512752832033;926.7451450850936;981.6809536900536;995.0944640377367;1003.9809593262844;14993.475228366955;15352.846471535366;15540.533783986499;15556.688866222612;15651.452199172974;403163;425102;436162;438409;660518;50583;50677.746611267445;50911.74544127256;51051.48948510467;51336.229956550684;1162.7325715085578;1174.0372894226653;1181.2794195540714;1187.8693343732182;1194.9820752688718;28188.859055705412;29551.408971820012;29660.851695741385;29990;30430.543541846448;42966.57033429751;43126.568734312255;43674.34488482739;43681.56318436775;43796.56203437925;357940;359379;360776;360887;361156;23656.881715591313;24468.265952020756;24504.509909802062;25426;26020.609690854275;39370.40944385894;39556.60443395529;39951.600483994785;40166.6874610106;40544.18911621692;32247.677523225408;32510.67489325171;32563.511547326336;32688.83655581707;32916.50625240671;34396.31207375888;35169;35202.47196292109;35393.29213415769;35440.11399715028;33094.66905330916;34582.48126278057;35009.474857876645;35917.28165436729;36526;32790.672093278765;34126;34147.14632134217;34229.65770342265;34232.14419639529;26095;26440.471190575696;26448.8677556611;26568.202953911412;26826.19521414361 05:50:14 INFO - PROCESS | 3454 | |2;jquery.html;371.8754217337192;375.75575875680806;378.3549048871674;379.18853653182214;381.81481981239097;16406.589835254126;16644.500664980056;17030.148492575383;17442.47672569825;17496.737548936777;17226.483205503853;17249.396271130514;18085.09574521272;18314.175862086206;18320.816791832076;5121.590272778169;5254.395744489375;5260.8684782880355;5286.709230992294;5287.947120528784;5168;5180.559652429548;5209.661372010826;5219.921701174486;5224.555912747421;5068.5691716204165;5175.24958880962;5181.326427564431;5185.948140518603;5202.713850738208;5073.974630126844;5115.437301896788;5149.9485005149845;5167.560757335631;5182.481751824825;4560.703554268962;4651.88370290742;4652.418447694038;4662.813487460531;4665.603423708989;18451.44645660632;19659.11533980974;19679.40961771149;20670.689939650918;21266.893665531574;1864.0959134819602;1968.252064215589;1981.4848139483695;2113.006886763219;2296.8966396512196;9487.193588544982;9565.713028609152;9642.662506812298;9675.903240967571;9736.75658108546;1707.137895362834;1820.8270214329618;1840.5030641726792;1842.7143792712152;1842.8986405747678;70132;75570;85970.57014714948;90594.54702726445;90735.54632226862;15851.682966340608;16595.751063734053;17035.659286814443;17648.823511764975;17963.101844907702;30057.549136762966;30112.84943575268;30179.09462716122;30391.69608303933;30408.087757367313;9108.544572771334;9393.295502837178;9470.100340467645;9531.142197202285;9624.326297159132;7868.527888326718;7968.12350641429;8068.677252909818;8072.878906816402;8128.837423251502;8597.097304783032;8687.870576825098;8750;8914.28685705142;8929.285657147413;3031.5149576067724;3344.2642618623863;3465.5841299044278;3533.318353182044;3643.049130204543;756.9394448444111;847.4237518487488;892.054422312351;926.1664501948301;959.9904000959901;17141.57146071358;17287.394941176997;17371.65256694859;17868.9106554469;18035.72946405805;815.1644564321617;839.5046922315863;878.9604467798964;898.9775255618662;914.3234006834895;9578.616855325849;9869.35849169816;10008.549615267331;10095.798084038279;10246.897531024744;281900;285537;286017;374144;377440;59677.40322596719;62378.37621623816;79008.60495697599;82462;82724;908.6774195160755;938.3572253006712;953.1183655118987;954.4750387286964;954.9856752148723;15909.363625454853;16166.838331617004;16379;16546.751798722787;17066.48800535986;37452.00383969222;38078.80960595179;38507.95666454982;39170.2165956685;39707.40438893477;49844.25233621571;51560;51624.48375516347;53131.73434132805;53554.19668704895;7540.8491830164185;7788.571628560484;7820.491668041559;7841.215878412113;8004.159563245776;8901.821963560564;12105;12362.44369003415;12496;12655.367231638196;10604.628837990942;10876.619318323821;10916.672499825017;10919.56321747153;10933.726656833325;10323.432211228455;10659;10696.251262411557;10878.45607719595;10943.616973405893;10445.791084178121;10682.198835087554;10789.352638841694;10958.726031849268;11416.486258118239;7492.325690687864;7945.324647404804;8120;8130.634121464666;8244.422890397855;9743.756406089904;10437.68686939393;10736.248462607542;10899.618513351994;10928.56285748593 05:50:14 INFO - PROCESS | 3454 | |3;mootools.html;1368.15858247178;1411.879990200833;1503.4587548482543;1678.2615649114396;1715.9313627454894;6770.187577490696;7534;7655.425843061765;8148.5518296493665;8153.510789352643;7705.691772329114;7928.841423171533;7929.722459713911;8004.239597238253;8019.518828870272;2201.3395981205613;2239.675247089171;2239.6864438978555;2244.7194100737406;2246.9438264043365;2229.4537838229658;2233.15140246706;2260.9095636174534;2281.74900760917;2290.7823756743164;2245.247841972941;2257.142285931352;2258.954820903581;2271.3299576624936;2273.715785526809;2228.1198926424136;2237.8321625878043;2241.1371621925596;2245.528439027806;2253.9406478954866;2133.5306232628795;2151.47288914217;2159.751628562704;2173.0981642618294;2174.7716489768504;8051.396145289127;8087.95956020222;8098.797530061736;8153.510789352657;8157.79605509867;4572.359869618256;4666.066786642651;4674.252119660872;4690.390249267608;4706.058788242365;2976.836274004929;3100.5504201890826;3182.740254419365;3186.8087914725193;3207.9679203208134;1032.2774058159318;1035.5805898611075;1041.4792603698152;1050.9527071281811;1057.7144171073844;10834.295770774874;10852.782944341068;10858.185636077247;10887.292325998786;10966.616168434066;4150.771707556113;4257.084726783756;4366.934495982563;4407.2507673695545;4420.292753159479;8874.64501419936;8953.104689530996;9032.051634578274;9193.356465047382;9293;4685.086408150446;4696.929546056812;4711.340412342206;4713.528647135259;4744.525547445228;3631.7276204284785;4091.284025295561;4149.2738770715005;4223.113146239262;4228.5982831630945;3759.379702349082;3803.258364618928;3820.0449887528116;3904.941425878614;3909.3940439231396;1226.3193927370396;1252.0734656354414;1259.6913756129807;1261.9432125554188;1270.4854533913779;828.3042244514637;829.3282441222628;861.7759382560454;864.740577826662;881.8677198420288;5007.724575148329;5056.191009438546;5074.340335756328;5177.197534382177;5293.523582877482;393.6929195227727;406.7864371205082;407.08406086305814;412.89264791154517;415.5325259083531;3538.2569660371096;3616.9819150904077;3640.6177351378255;3663.8534458621357;3698.519192504957;9401.71794846142;9665.951670241744;9709.36889102206;9723.465209413409;9740.318177727491;9706.514674266258;9713.90286097144;9718.368306060083;9752.9024709752;9788.853167202355;7484.176740558534;7534.773956781305;7642.159362470124;7651.234876512415;7657.502262352929;5205.973970130125;5277.947220527745;5310.230016647642;5321.733913304397;5403.0544654686055;9121.817563648823;9148.771280718036;9165;9189.540522973959;9198.862017069616;8581.785455363666;8940.5082720451;8960.32797540174;9204.907950920406;9211.76970575741;6152.169457123231;6681.1314529110905;6928.93071069303;6942.444604431735;7081.716731330689;7714.922850771645;7725.5364678119495;7737.14891361961;7754.108277548155;7794.961025194838;6755.932440675727;6885.518013739191;6931.480138989697;6948.200956890022;7139.892901606376;6733.225679046776;6833.555818871758;6844.828879278058;6855.520113592001;7127.2516385778745;6372.713227904663;6373.171487706569;6413.2945376007665;6416.358364163733;6434.64609446485;4477.395551600493;4521.84173553924;4568.246239370466;4592.88517787058;4625.329327247463;4713.434387873477;4764.071006153906;4866.756662166807;4867.464578896389;4873.878153046202 05:50:14 INFO - PROCESS | 3454 | |4;prototype.html;299.32054236882277;300.1939791659395;302.0816717179774;302.67311303791905;307.38829728839613;5215.86960325992;5216.6087543434205;5224.791008359661;5237.10969135247;5246.714554934042;5076.771545280462;5094.566961808251;5120.385553733558;5129.2306154076905;5144.588432925367;3806.6764325032336;3903.7657740535515;4006.659433948118;4019.31671615826;4022.255882661717;4013.377926421395;4015.4980627421573;4019.296623090962;4022.8189731462153;4041.747058411902;3952.308346039446;3979.9851037985272;4007.5391329996987;4008.4388185654034;4009;3747.6065013173497;3978.4827972363696;3993.5407428145845;4018.477597912282;4032.0927791247027;3459.6713312235547;3460;3461.930761384783;3463.4458486642015;3465.7350067225534;5015.498450154992;5039.874003149914;5057.115004874132;5083.135866902636;5115.667481613683;4292.806823692941;4552.863414097583;4566.26939689648;4591.829083583665;4597.3793537872625;5334.386545547234;5340.62615616907;5344.9732751336;5351.438098999588;5369.24830523727;3796.2976849282973;3801.6958643308467;3830.9616903830884;3841.1754416652147;3842.3083844907906;5383.43473935235;5676.432356764331;5687.744051517691;5688.459596338341;5695.1741997410145;3898.8050597470015;3905.453236546886;3916.3342231820657;3926.1951299984007;3931.5478719947;3913.25648126855;3933.4689816874356;3969.226000929791;3971.384435412516;3983;4491.595756381876;4513.842015529441;4529.184746745552;4529.38853254813;4533.252013417749;5128.845635035633;5402.756875940592;5409.702466364309;5417.859945321655;5484.177373393943;1351.1420248142501;1354.9634529584876;1370.5271681269946;1376.1742954227584;1379.496348979597;847.2967437027253;863.5250612163285;879.9296056315608;889.9065598112235;890.799570096736;4606.815727370935;4629.953700462952;4642.187617166982;4653.906921861611;4658.114958158007;5443.891122177613;5470.9452905471235;5474.178873169057;5493.972530137404;5506.752196151183;4568.898306778852;4627.259638457831;4682.869294471007;4688.437387513521;4694.366260554782;2898.6086878271162;2915.6646985596926;2915.795894287422;2919.255589824581;2941.8379740003006;5084.542391184811;5094.465081166498;5099.5410413063;5118.513741194581;5131.435542090367;5364.8122315718765;5563.025126080264;5574.554035677136;5601.747921343549;5603.747831347518;5065.13892638245;5076.857707015892;5085.262636917626;5109.3905419792645;5128.69227846323;5460.972695136499;5462.180672899097;5465.289512363367;5483.341998959991;5489.64317319373;5257.7371131442505;5367.329083864517;5368.677879327252;5372.570194384518;5426.755795989269;5090;5097.7706003229205;5099.311592934906;5111.948880511147;5160.664556803796;3819.942700859545;3824.7322687411615;3847;3867.0912335601674;3881.1073453105378;5300.867478313073;5355.651882627617;5454.1365782962675;5496.80761173357;5511.311086114236;5265.4997775211295;5274.525292723673;5326.414094449685;5343.7862485500145;5354.973225134006;5156.1492353761205;5252.527272545489;5261.131913234273;5298.761555730079;5303.602229832701;5219.817306394258;5221.060209162387;5232.319798426181;5232.476752324889;5270.443834740225;5104.285400044071;5193.76628051731;5330.227117068081;5380.569554435714;5410.59420543453;5276.314079169683;5277.630565860506;5277.762500687555;5303.817709374344;5309.973450132725 05:50:14 INFO - PROCESS | 3454 | |5;yui.html;611.6849822341494;687.0861753867354;687.2646268492708;736.887300176733;738.8522295540893;12616.936915315422;13386.531471398503;13420.463181472755;13432.126911750742;13473.663158421032;12244.510219591228;12640.873591264084;12849.743005139915;13073.803892941589;13207.273599952;772.1814876231199;788.2117882117882;789.9802504937365;790.7113903425266;792.2829838995689;780.3679019993823;782.295933659708;782.9843403131963;783.4946459533597;786.7875673568133;809.4050872608628;815.254042551065;820.4748960665149;820.9671613135467;821.1706176761454;817.0440584516131;818.3085292927497;818.6520728690283;822.9588520574007;823.8970128733908;596.8418369132183;597.5428796970322;600.4595863722684;602.2832828933555;604.5163868904858;11675.824862627067;11689;11747.47136378865;11749.060075193964;11790;10865.727456723554;11004.889951100467;11121.110311175087;11132.888671113265;11392.943035284854;9714.61141554337;9810.754731131707;9826.950865245699;9967.950160249226;10244.180465562811;4222.873313800591;4232.386303985905;4249.490061192646;4264.6801489888385;4310.4611923509565;40317.193656126714;43585.56414435847;59341;59527.70236148835;60016.69991650058;9815.36200146988;9942.701718948443;9979.151772099307;10169.694909152737;10265.384076955406;17331.4800555981;17425.738613920803;17496.825031749773;17612.647747044986;17675.381361652282;6619.5035372347265;6651.600903945779;6665.100211471389;6787.592744435349;6793.932060679429;3465.6187819339852;3491.877784277538;3561.3411518869093;3597.8201089945924;3609.7653652512504;2895.7683385329124;2986.074316961749;2986.7759918006236;3452.37857185704;3644.799536025544;591.7899145803264;598.7604958016741;598.8980276291558;598.9011813050798;607.884501944629;535.5929493584904;557.9609427340047;580.9767609295666;644.5649186798892;645.6739346629922;8619;9116.954415227881;9748.805023899624;9775.951120244354;9962.252831037702;570.9854438226452;577.7053702611698;614.8370681769335;623.5635055461196;635.5836926812945;4026.255142798533;4100.302948498763;4151.14901445203;4195.706300558932;4265.616094551505;56487.15269270964;56488;56807.715961419926;78870.6056469714;94829;66738.66630666815;75747.62126189334;81575.59212203902;85934;88505.55747221223;49447.50552494501;67085;69194;78721.60639196882;79077.60461197772;8708.960897630315;9062.501562413867;9157.31320150978;9172.266218702354;9210.309226808151;33034.339313214085;40012.399814003395;41272.587274126876;45163.09673806571;45884.54115458803;60423.697881510314;61019;62621;67512.3248767506;68825;10952.39761813076;10957.452127393439;11126.165537584875;11134.665960021212;11136.832947505956;12886.67783305425;13466.93266533661;13514.797278041035;13664.65838354049;13767.449302027806;11061.446927653746;11083.501242443948;11122.538642808528;11133.721656958642;11876.584319548774;11648.791705489526;11775.823362649397;11995;12130.514779408724;12539.811902821282;12243.938780306042;12325.198862073936;12489.93755031219;12763.361831908553;12885;9242.537873106452;9256;9454.149126578366;9457.905420945977;9591.952040239754;9409.764755881159;9806;9840.655577055055;9855.655052073143;10040.347377420445 05:50:14 INFO - PROCESS | 3454 | __end_tp_report 05:50:14 INFO - PROCESS | 3454 | __start_cc_report 05:50:14 INFO - PROCESS | 3454 | _x_x_mozilla_cycle_collect,416 05:50:14 INFO - PROCESS | 3454 | __end_cc_report 05:50:14 INFO - PROCESS | 3454 | __startTimestamp1467636614347__endTimestamp 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | ------- Summary: start ------- 05:50:14 INFO - PROCESS | 3454 | Number of tests: 6 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | [#0] dojo.html Cycles:165 Average:4763.86 Median:4900.51 stddev:610.37 (12.5%) stddev-sans-first:588.20 05:50:14 INFO - PROCESS | 3454 | Values: 2601.8 2668.8 2669.9 2686.6 2686.9 4760.2 4781.0 4807.1 4839.8 4905.5 4704.9 4788.5 4814.4 4817.5 4825.9 4385.8 4420.8 4536.0 4542.9 4545.9 579.6 4350.9 4365.4 4384.5 4477.7 4401.8 4425.3 4435.4 4437.8 4487.0 4445.2 4448.5 4455.6 4459.8 4485.5 4302.0 4389.4 4405.1 4409.3 4413.6 4747.1 4839.7 4848.5 4866.1 4876.4 5089.4 5214.6 5217.1 5218.8 5275.4 5138.2 5176.5 5182.7 5185.0 5239.1 4795.3 4820.6 4825.7 4826.9 4875.0 5258.3 5301.4 5315.2 5330.7 5335.4 5107.4 5109.0 5117.7 5123.5 5171.3 5212.6 5217.5 5220.9 5227.6 5255.4 4993.8 5092.9 5141.9 5147.5 5172.5 5130.1 5136.9 5137.3 5158.0 5168.8 4383.2 4390.6 4391.6 4413.5 4442.6 3786.9 3787.5 3794.7 3807.7 3847.5 4454.7 4462.8 4474.2 4475.2 4562.1 5236.3 5241.8 5248.9 5250.4 5253.6 4411.6 4460.3 4473.8 4484.7 4488.2 4628.7 4646.6 4649.9 4663.6 4679.3 4720.4 4858.1 4887.6 4900.5 4936.5 5148.3 5165.5 5223.1 5235.4 5239.0 4851.6 4868.8 4871.4 4876.0 4910.9 5049.0 5139.0 5146.1 5148.6 5149.3 5168.0 5206.0 5217.8 5228.7 5279.9 5063.4 5076.1 5076.8 5101.5 5134.7 4881.9 5034.1 5048.0 5059.6 5066.2 4947.2 4961.3 5000.9 5004.5 5055.1 5130.4 5131.2 5146.5 5156.0 5167.0 4861.7 4974.1 5004.8 5016.8 5027.4 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | [#1] ext.html Cycles:180 Average:50240.61 Median:198426.82 stddev:101006.03 (50.9%) stddev-sans-first:101220.55 05:50:14 INFO - PROCESS | 3454 | Values: 578.5 585.8 588.6 591.1 625.5 36077.6 40406.2 40418.4 40498.0 40572.8 40761.8 41027.4 41087.4 41192.6 41261.4 7790.9 7916.6 7916.6 7921.8 7947.8 7786.0 7906.4 7917.2 7927.6 7959.0 7940.5 7943.6 7944.0 7944.7 7961.2 7905.0 7907.2 7956.0 7962.6 7965.8 7801.1 7845.5 7892.6 7899.7 7904.1 38667.8 38883.8 38972.8 38981.8 39070.4 2997.3 3126.2 3366.5 3687.5 3813.1 30249.4 30476.0 30508.8 30698.5 31670.4 3594.9 3604.8 3646.3 3649.1 3715.4 264156.0 264370.0 265123.0 266156.0 266656.0 31943.8 33009.7 52611.5 53150.7 53156.5 33994.7 33997.7 34040.0 34133.7 34275.8 13216.7 13339.5 13371.3 13383.9 13399.9 10476.1 10530.3 10549.5 10556.3 10578.4 7839.3 7936.2 7959.1 8041.8 8046.1 3110.4 3135.7 3141.2 3161.4 3174.4 842.1 870.2 923.6 966.2 1031.1 28203.7 29048.0 29264.9 29430.9 29463.6 874.9 926.7 981.7 995.1 1004.0 14993.5 15352.8 15540.5 15556.7 15651.5 403163.0 425102.0 436162.0 438409.0 660518.0 50583.0 50677.7 50911.7 51051.5 51336.2 1162.7 1174.0 1181.3 1187.9 1195.0 28188.9 29551.4 29660.9 29990.0 30430.5 42966.6 43126.6 43674.3 43681.6 43796.6 357940.0 359379.0 360776.0 360887.0 361156.0 23656.9 24468.3 24504.5 25426.0 26020.6 39370.4 39556.6 39951.6 40166.7 40544.2 32247.7 32510.7 32563.5 32688.8 32916.5 34396.3 35169.0 35202.5 35393.3 35440.1 33094.7 34582.5 35009.5 35917.3 36526.0 32790.7 34126.0 34147.1 34229.7 34232.1 26095.0 26440.5 26448.9 26568.2 26826.2 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | [#2] jquery.html Cycles:180 Average:23759.31 Median:22134.05 stddev:54250.32 (245.1%) stddev-sans-first:54374.08 05:50:14 INFO - PROCESS | 3454 | Values: 371.9 375.8 378.4 379.2 381.8 16406.6 16644.5 17030.1 17442.5 17496.7 17226.5 17249.4 18085.1 18314.2 18320.8 5121.6 5254.4 5260.9 5286.7 5287.9 5168.0 5180.6 5209.7 5219.9 5224.6 5068.6 5175.2 5181.3 5185.9 5202.7 5074.0 5115.4 5149.9 5167.6 5182.5 4560.7 4651.9 4652.4 4662.8 4665.6 18451.4 19659.1 19679.4 20670.7 21266.9 1864.1 1968.3 1981.5 2113.0 2296.9 9487.2 9565.7 9642.7 9675.9 9736.8 1707.1 1820.8 1840.5 1842.7 1842.9 70132.0 75570.0 85970.6 90594.5 90735.5 15851.7 16595.8 17035.7 17648.8 17963.1 30057.5 30112.8 30179.1 30391.7 30408.1 9108.5 9393.3 9470.1 9531.1 9624.3 7868.5 7968.1 8068.7 8072.9 8128.8 8597.1 8687.9 8750.0 8914.3 8929.3 3031.5 3344.3 3465.6 3533.3 3643.0 756.9 847.4 892.1 926.2 960.0 17141.6 17287.4 17371.7 17868.9 18035.7 815.2 839.5 879.0 899.0 914.3 9578.6 9869.4 10008.5 10095.8 10246.9 281900.0 285537.0 286017.0 374144.0 377440.0 59677.4 62378.4 79008.6 82462.0 82724.0 908.7 938.4 953.1 954.5 955.0 15909.4 16166.8 16379.0 16546.8 17066.5 37452.0 38078.8 38508.0 39170.2 39707.4 49844.3 51560.0 51624.5 53131.7 53554.2 7540.8 7788.6 7820.5 7841.2 8004.2 8901.8 12105.0 12362.4 12496.0 12655.4 10604.6 10876.6 10916.7 10919.6 10933.7 10323.4 10659.0 10696.3 10878.5 10943.6 10445.8 10682.2 10789.4 10958.7 11416.5 7492.3 7945.3 8120.0 8130.6 8244.4 9743.8 10437.7 10736.2 10899.6 10928.6 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | [#3] mootools.html Cycles:180 Average:5218.76 Median:4754.30 stddev:2923.48 (61.5%) stddev-sans-first:2917.35 05:50:14 INFO - PROCESS | 3454 | Values: 1368.2 1411.9 1503.5 1678.3 1715.9 6770.2 7534.0 7655.4 8148.6 8153.5 7705.7 7928.8 7929.7 8004.2 8019.5 2201.3 2239.7 2239.7 2244.7 2246.9 2229.5 2233.2 2260.9 2281.7 2290.8 2245.2 2257.1 2259.0 2271.3 2273.7 2228.1 2237.8 2241.1 2245.5 2253.9 2133.5 2151.5 2159.8 2173.1 2174.8 8051.4 8088.0 8098.8 8153.5 8157.8 4572.4 4666.1 4674.3 4690.4 4706.1 2976.8 3100.6 3182.7 3186.8 3208.0 1032.3 1035.6 1041.5 1051.0 1057.7 10834.3 10852.8 10858.2 10887.3 10966.6 4150.8 4257.1 4366.9 4407.3 4420.3 8874.6 8953.1 9032.1 9193.4 9293.0 4685.1 4696.9 4711.3 4713.5 4744.5 3631.7 4091.3 4149.3 4223.1 4228.6 3759.4 3803.3 3820.0 3904.9 3909.4 1226.3 1252.1 1259.7 1261.9 1270.5 828.3 829.3 861.8 864.7 881.9 5007.7 5056.2 5074.3 5177.2 5293.5 393.7 406.8 407.1 412.9 415.5 3538.3 3617.0 3640.6 3663.9 3698.5 9401.7 9666.0 9709.4 9723.5 9740.3 9706.5 9713.9 9718.4 9752.9 9788.9 7484.2 7534.8 7642.2 7651.2 7657.5 5206.0 5277.9 5310.2 5321.7 5403.1 9121.8 9148.8 9165.0 9189.5 9198.9 8581.8 8940.5 8960.3 9204.9 9211.8 6152.2 6681.1 6928.9 6942.4 7081.7 7714.9 7725.5 7737.1 7754.1 7795.0 6755.9 6885.5 6931.5 6948.2 7139.9 6733.2 6833.6 6844.8 6855.5 7127.3 6372.7 6373.2 6413.3 6416.4 6434.6 4477.4 4521.8 4568.2 4592.9 4625.3 4713.4 4764.1 4866.8 4867.5 4873.9 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | [#4] prototype.html Cycles:180 Average:4428.36 Median:5094.52 stddev:1287.91 (25.3%) stddev-sans-first:1253.68 05:50:14 INFO - PROCESS | 3454 | Values: 299.3 300.2 302.1 302.7 307.4 5215.9 5216.6 5224.8 5237.1 5246.7 5076.8 5094.6 5120.4 5129.2 5144.6 3806.7 3903.8 4006.7 4019.3 4022.3 4013.4 4015.5 4019.3 4022.8 4041.7 3952.3 3980.0 4007.5 4008.4 4009.0 3747.6 3978.5 3993.5 4018.5 4032.1 3459.7 3460.0 3461.9 3463.4 3465.7 5015.5 5039.9 5057.1 5083.1 5115.7 4292.8 4552.9 4566.3 4591.8 4597.4 5334.4 5340.6 5345.0 5351.4 5369.2 3796.3 3801.7 3831.0 3841.2 3842.3 5383.4 5676.4 5687.7 5688.5 5695.2 3898.8 3905.5 3916.3 3926.2 3931.5 3913.3 3933.5 3969.2 3971.4 3983.0 4491.6 4513.8 4529.2 4529.4 4533.3 5128.8 5402.8 5409.7 5417.9 5484.2 1351.1 1355.0 1370.5 1376.2 1379.5 847.3 863.5 879.9 889.9 890.8 4606.8 4630.0 4642.2 4653.9 4658.1 5443.9 5470.9 5474.2 5494.0 5506.8 4568.9 4627.3 4682.9 4688.4 4694.4 2898.6 2915.7 2915.8 2919.3 2941.8 5084.5 5094.5 5099.5 5118.5 5131.4 5364.8 5563.0 5574.6 5601.7 5603.7 5065.1 5076.9 5085.3 5109.4 5128.7 5461.0 5462.2 5465.3 5483.3 5489.6 5257.7 5367.3 5368.7 5372.6 5426.8 5090.0 5097.8 5099.3 5111.9 5160.7 3819.9 3824.7 3847.0 3867.1 3881.1 5300.9 5355.7 5454.1 5496.8 5511.3 5265.5 5274.5 5326.4 5343.8 5355.0 5156.1 5252.5 5261.1 5298.8 5303.6 5219.8 5221.1 5232.3 5232.5 5270.4 5104.3 5193.8 5330.2 5380.6 5410.6 5276.3 5277.6 5277.8 5303.8 5310.0 05:50:14 INFO - PROCESS | 3454 | 05:50:14 INFO - PROCESS | 3454 | [#5] yui.html Cycles:180 Average:16315.25 Median:29966.39 stddev:22171.45 (74.0%) stddev-sans-first:22202.29 05:50:14 INFO - PROCESS | 3454 | Values: 611.7 687.1 687.3 736.9 738.9 12616.9 13386.5 13420.5 13432.1 13473.7 12244.5 12640.9 12849.7 13073.8 13207.3 772.2 788.2 790.0 790.7 792.3 780.4 782.3 783.0 783.5 786.8 809.4 815.3 820.5 821.0 821.2 817.0 818.3 818.7 823.0 823.9 596.8 597.5 600.5 602.3 604.5 11675.8 11689.0 11747.5 11749.1 11790.0 10865.7 11004.9 11121.1 11132.9 11392.9 9714.6 9810.8 9827.0 9968.0 10244.2 4222.9 4232.4 4249.5 4264.7 4310.5 40317.2 43585.6 59341.0 59527.7 60016.7 9815.4 9942.7 9979.2 10169.7 10265.4 17331.5 17425.7 17496.8 17612.6 17675.4 6619.5 6651.6 6665.1 6787.6 6793.9 3465.6 3491.9 3561.3 3597.8 3609.8 2895.8 2986.1 2986.8 3452.4 3644.8 591.8 598.8 598.9 598.9 607.9 535.6 558.0 581.0 644.6 645.7 8619.0 9117.0 9748.8 9776.0 9962.3 571.0 577.7 614.8 623.6 635.6 4026.3 4100.3 4151.1 4195.7 4265.6 56487.2 56488.0 56807.7 78870.6 94829.0 66738.7 75747.6 81575.6 85934.0 88505.6 49447.5 67085.0 69194.0 78721.6 79077.6 8709.0 9062.5 9157.3 9172.3 9210.3 33034.3 40012.4 41272.6 45163.1 45884.5 60423.7 61019.0 62621.0 67512.3 68825.0 10952.4 10957.5 11126.2 11134.7 11136.8 12886.7 13466.9 13514.8 13664.7 13767.4 11061.4 11083.5 11122.5 11133.7 11876.6 11648.8 11775.8 11995.0 12130.5 12539.8 12243.9 12325.2 12489.9 12763.4 12885.0 9242.5 9256.0 9454.1 9457.9 9592.0 9409.8 9806.0 9840.7 9855.7 10040.3 05:50:14 INFO - PROCESS | 3454 | -------- Summary: end -------- 05:50:14 INFO - PROCESS | 3454 | 05:50:15 INFO - TEST-INFO | 3454: exit 0 05:50:15 INFO - TEST-OK | dromaeo_css | took 1118417ms 05:50:15 INFO - TEST-START | kraken 05:50:15 INFO - operating with platform_type : linux_ 05:50:15 INFO - Initialising browser for kraken test... 05:50:15 INFO - TEST-INFO | started process 3696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDWsfr/profile http://localhost:47499/getInfo.html) 05:50:20 INFO - PROCESS | 3696 | __metrics Screen width/height:1600/1200 05:50:20 INFO - PROCESS | 3696 | colorDepth:24 05:50:20 INFO - PROCESS | 3696 | Browser inner width/height: 1024/697 05:50:20 INFO - PROCESS | 3696 | __metrics 05:50:20 ERROR - PROCESS | 3696 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:50:21 INFO - TEST-INFO | 3696: exit 0 05:50:21 INFO - Browser initialized. 05:50:21 INFO - Running cycle 1/1 for kraken test... 05:50:21 INFO - TEST-INFO | started process 3813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDWsfr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:33 INFO - PROCESS | 3813 | RSS: Main: 169857024 05:50:33 INFO - PROCESS | 3813 | 05:50:36 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47499/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:37 INFO - PROCESS | 3813 | RSS: Main: 174956544 05:50:37 INFO - PROCESS | 3813 | 05:50:40 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47499/tests/kraken/driver.html?testName=audio-dft) 05:50:40 INFO - PROCESS | 3813 | RSS: Main: 174772224 05:50:40 INFO - PROCESS | 3813 | 05:50:43 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47499/tests/kraken/driver.html?testName=audio-fft) 05:50:44 INFO - PROCESS | 3813 | RSS: Main: 169394176 05:50:44 INFO - PROCESS | 3813 | 05:50:46 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47499/tests/kraken/driver.html?testName=audio-oscillator) 05:50:47 INFO - PROCESS | 3813 | RSS: Main: 170000384 05:50:47 INFO - PROCESS | 3813 | 05:50:49 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:49 INFO - PROCESS | 3813 | RSS: Main: 169885696 05:50:49 INFO - PROCESS | 3813 | 05:50:53 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47499/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:53 INFO - PROCESS | 3813 | RSS: Main: 170536960 05:50:53 INFO - PROCESS | 3813 | 05:50:57 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47499/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:58 INFO - PROCESS | 3813 | RSS: Main: 167776256 05:50:58 INFO - PROCESS | 3813 | 05:51:01 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47499/tests/kraken/driver.html?testName=json-parse-financial) 05:51:01 INFO - PROCESS | 3813 | RSS: Main: 169283584 05:51:01 INFO - PROCESS | 3813 | 05:51:03 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:04 INFO - PROCESS | 3813 | RSS: Main: 170012672 05:51:04 INFO - PROCESS | 3813 | 05:51:05 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:06 INFO - PROCESS | 3813 | RSS: Main: 169869312 05:51:06 INFO - PROCESS | 3813 | 05:51:08 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:09 INFO - PROCESS | 3813 | RSS: Main: 170442752 05:51:09 INFO - PROCESS | 3813 | 05:51:12 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:13 INFO - PROCESS | 3813 | RSS: Main: 168128512 05:51:13 INFO - PROCESS | 3813 | 05:51:16 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:17 INFO - PROCESS | 3813 | RSS: Main: 169168896 05:51:17 INFO - PROCESS | 3813 | 05:51:18 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47499/tests/kraken/driver.html?testName=ai-astar) 05:51:19 INFO - PROCESS | 3813 | RSS: Main: 170213376 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | __start_tp_report 05:51:19 INFO - PROCESS | 3813 | _x_x_mozilla_page_load 05:51:19 INFO - PROCESS | 3813 | _x_x_mozilla_page_load_details 05:51:19 INFO - PROCESS | 3813 | |i|pagename|runs| 05:51:19 INFO - PROCESS | 3813 | |0;ai-astar;105;116;110;118;114;114;113;114;112;113 05:51:19 INFO - PROCESS | 3813 | |1;audio-beat-detection;149;124;157;189;124;151;144;125;182;121 05:51:19 INFO - PROCESS | 3813 | |2;audio-dft;166;162;169;167;168;162;164;161;165;161 05:51:19 INFO - PROCESS | 3813 | |3;audio-fft;76;79;76;154;77;77;75;75;169;79 05:51:19 INFO - PROCESS | 3813 | |4;audio-oscillator;87;85;137;87;86;88;137;86;85;141 05:51:19 INFO - PROCESS | 3813 | |5;imaging-gaussian-blur;122;117;117;117;117;118;120;117;118;117 05:51:19 INFO - PROCESS | 3813 | |6;imaging-darkroom;148;147;147;147;147;147;148;149;150;148 05:51:19 INFO - PROCESS | 3813 | |7;imaging-desaturate;95;95;99;95;95;95;95;95;95;95 05:51:19 INFO - PROCESS | 3813 | |8;json-parse-financial;66;69;68;67;66;65;67;69;67;66 05:51:19 INFO - PROCESS | 3813 | |9;json-stringify-tinderbox;65;66;65;65;66;65;65;67;67;68 05:51:19 INFO - PROCESS | 3813 | |10;stanford-crypto-aes;79;81;79;79;86;80;80;85;85;88 05:51:19 INFO - PROCESS | 3813 | |11;stanford-crypto-ccm;130;130;129;141;140;131;131;131;187;132 05:51:19 INFO - PROCESS | 3813 | |12;stanford-crypto-pbkdf2;179;180;173;173;176;175;175;176;181;175 05:51:19 INFO - PROCESS | 3813 | |13;stanford-crypto-sha256-iterative;72;72;70;68;72;70;68;66;67;68 05:51:19 INFO - PROCESS | 3813 | __end_tp_report 05:51:19 INFO - PROCESS | 3813 | __start_cc_report 05:51:19 INFO - PROCESS | 3813 | _x_x_mozilla_cycle_collect,1005 05:51:19 INFO - PROCESS | 3813 | __end_cc_report 05:51:19 INFO - PROCESS | 3813 | __startTimestamp1467636679095__endTimestamp 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | ------- Summary: start ------- 05:51:19 INFO - PROCESS | 3813 | Number of tests: 14 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.51 (3.1%) stddev-sans-first:2.28 05:51:19 INFO - PROCESS | 3813 | Values: 105.0 116.0 110.0 118.0 114.0 114.0 113.0 114.0 112.0 113.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:150.00 stddev:24.35 (16.2%) stddev-sans-first:25.81 05:51:19 INFO - PROCESS | 3813 | Values: 149.0 124.0 157.0 189.0 124.0 151.0 144.0 125.0 182.0 121.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.50 stddev:2.95 (1.8%) stddev-sans-first:3.08 05:51:19 INFO - PROCESS | 3813 | Values: 166.0 162.0 169.0 167.0 168.0 162.0 164.0 161.0 165.0 161.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.50 stddev:35.94 (47.0%) stddev-sans-first:37.54 05:51:19 INFO - PROCESS | 3813 | Values: 76.0 79.0 76.0 154.0 77.0 77.0 75.0 75.0 169.0 79.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:86.00 stddev:25.18 (29.3%) stddev-sans-first:26.13 05:51:19 INFO - PROCESS | 3813 | Values: 87.0 85.0 137.0 87.0 86.0 88.0 137.0 86.0 85.0 141.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:117.50 stddev:1.70 (1.4%) stddev-sans-first:1.01 05:51:19 INFO - PROCESS | 3813 | Values: 122.0 117.0 117.0 117.0 117.0 118.0 120.0 117.0 118.0 117.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 05:51:19 INFO - PROCESS | 3813 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 148.0 149.0 150.0 148.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 05:51:19 INFO - PROCESS | 3813 | Values: 95.0 95.0 99.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 05:51:19 INFO - PROCESS | 3813 | Values: 66.0 69.0 68.0 67.0 66.0 65.0 67.0 69.0 67.0 66.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 05:51:19 INFO - PROCESS | 3813 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 65.0 67.0 67.0 68.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:83.00 stddev:3.43 (4.1%) stddev-sans-first:3.43 05:51:19 INFO - PROCESS | 3813 | Values: 79.0 81.0 79.0 79.0 86.0 80.0 80.0 85.0 85.0 88.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:131.50 stddev:17.66 (13.4%) stddev-sans-first:18.48 05:51:19 INFO - PROCESS | 3813 | Values: 130.0 130.0 129.0 141.0 140.0 131.0 131.0 131.0 187.0 132.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.00 stddev:2.79 (1.6%) stddev-sans-first:2.78 05:51:19 INFO - PROCESS | 3813 | Values: 179.0 180.0 173.0 173.0 176.0 175.0 175.0 176.0 181.0 175.0 05:51:19 INFO - PROCESS | 3813 | 05:51:19 INFO - PROCESS | 3813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:2.21 (3.2%) stddev-sans-first:2.12 05:51:19 INFO - PROCESS | 3813 | Values: 72.0 72.0 70.0 68.0 72.0 70.0 68.0 66.0 67.0 68.0 05:51:19 INFO - PROCESS | 3813 | -------- Summary: end -------- 05:51:19 INFO - PROCESS | 3813 | 05:51:20 INFO - TEST-INFO | 3813: exit 0 05:51:20 INFO - TEST-OK | kraken | took 65061ms 05:51:20 INFO - SUITE-END | took 1183s 05:51:20 INFO - Completed test suite (00:19:43) 05:51:20 INFO - javascript benchmark 05:51:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6529.728754143096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.7658410743034, 2668.839869607824, 2669.906553270636, 2686.5567181415054, 2686.9328266793327, 4760.166970780113, 4781.043791241753, 4807.08665353583, 4839.831485235083, 4905.460399356077, 4704.85885423437, 4788.497207793183, 4814.398200224972, 4817.494163112867, 4825.927611085836, 4385.846495372654, 4420.806720182919, 4536.047430039695, 4542.8864278392975, 4545.909081818361, 579.5780825403212, 4350.934735978963, 4365.36702178184, 4384.451943507046, 4477.70894891831, 4401.823927042915, 4425.269830477967, 4435.445569303837, 4437.778111094464, 4487.0, 4445.155420470101, 4448.510663826976, 4455.643548516111, 4459.843905463325, 4485.529019452975, 4301.956980430187, 4389.363542286383, 4405.074934263776, 4409.316555933835, 4413.558644135593, 4747.121782470254, 4839.661223714342, 4848.490908454632, 4866.075445665312, 4876.390451193601, 5089.3638295213095, 5214.582833373321, 5217.060929032773, 5218.843434696965, 5275.419703832576, 5138.229265610151, 5176.482351764831, 5182.689038657692, 5184.974075129638, 5239.109351410231, 4795.328653988445, 4820.614350851958, 4825.662203645781, 4826.903461930812, 4874.975625121887, 5258.342707161605, 5301.443348448434, 5315.229291752674, 5330.733463326818, 5335.413104558495, 5107.412647545506, 5108.974455127701, 5117.667351622133, 5123.538881500608, 5171.3018742469285, 5212.635115541952, 5217.530422262014, 5220.895582088337, 5227.60792940531, 5255.421903590602, 4993.775280112331, 5092.898142037138, 5141.948580514222, 5147.510986456281, 5172.456892026358, 5130.076586214443, 5136.921246538269, 5137.33214682089, 5158.0199762045095, 5168.819091331786, 4383.211022016004, 4390.626796722315, 4391.626711729538, 4413.470383553994, 4442.622377097919, 3786.8674596388996, 3787.5265591801026, 3794.734368594172, 3807.695384369244, 3847.461355410245, 4454.710443821141, 4462.843800466968, 4474.239379305526, 4475.172093162711, 4562.08758248345, 5236.266922630834, 5241.764120614582, 5248.921266181011, 5250.448702886219, 5253.632245742761, 4411.625011873963, 4460.286354183315, 4473.843415480443, 4484.730916145042, 4488.214562451558, 4628.699134556243, 4646.581807637329, 4649.907001859944, 4663.580277775017, 4679.344891715163, 4720.433547974265, 4858.125537403302, 4887.584555312838, 4900.5099490052135, 4936.456989731127, 5148.30497882796, 5165.509276618715, 5223.112070948024, 5235.397929238034, 5239.0, 4851.58761505276, 4868.829590964299, 4871.439784424695, 4876.0, 4910.9017819642695, 5049.015441988777, 5138.97430512845, 5146.099432599205, 5148.58811295088, 5149.253358263106, 5168.043911876315, 5206.036883176473, 5217.791288348575, 5228.660137091077, 5279.868003299948, 5063.417706963746, 5076.11168045598, 5076.847694569169, 5101.540861322499, 5134.743262836918, 4881.877953051202, 5034.144195486703, 5047.974760126176, 5059.5952323814745, 5066.214736715815, 4947.233178857283, 4961.330220420341, 5000.949990500194, 5004.549590536869, 5055.1153548128195, 5130.384353877409, 5131.153359695609, 5146.459621739664, 5155.9742201288755, 5167.044096842096, 4861.6596838220985, 4974.054929563371, 5004.84985450437, 5016.824411145738, 5027.371578552681], "value": 4725.543136261147, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.5140481995123, 585.8037557418262, 588.5997521685252, 591.0956236957455, 625.5402279324699, 36077.63922360776, 40406.191876162535, 40418.39372409416, 40497.99999999996, 40572.79713601428, 40761.79619101908, 41027.38458923119, 41087.38368924461, 41192.58807411925, 41261.381079283834, 7790.922090779076, 7916.604169791516, 7916.643751031189, 7921.841563168733, 7947.841043179133, 7785.961070194641, 7906.407019473534, 7917.208279172094, 7927.643256053491, 7959.044914610255, 7940.483868548555, 7943.5631040292765, 7943.960280198591, 7944.682212711514, 7961.164077771838, 7905.0, 7907.169747176578, 7956.045274567031, 7962.641681124334, 7965.840683186333, 7801.0638723352995, 7845.490043147177, 7892.644830982562, 7899.723509677134, 7904.09102953162, 38667.80666096652, 38883.8055809722, 38972.80513597414, 38981.805090974645, 39070.41394379087, 2997.250687328168, 3126.234072652192, 3366.4613661814237, 3687.46531752897, 3813.0848596336677, 30249.395012099856, 30476.0, 30508.8474557628, 30698.53952190719, 31670.36659266802, 3594.856205751767, 3604.8017359045243, 3646.3254297954963, 3649.105969037603, 3715.442683597455, 264156.0, 264370.0, 265123.0, 266156.0, 266656.0, 31943.84028079891, 33009.66990330066, 52611.473885261425, 53150.734246329295, 53156.46843531515, 33994.660053399646, 33997.66002339994, 34040.0, 34133.658663413546, 34275.82862085674, 13216.73566528664, 13339.533116340881, 13371.264580448169, 13383.866161338457, 13399.933000334935, 10476.0571548561, 10530.31552949056, 10549.525271362807, 10556.261061725605, 10578.365298082139, 7839.25527074927, 7936.206379362017, 7959.124496305518, 8041.798955026171, 8046.114927357986, 3110.3934732726902, 3135.745701719285, 3141.246100935759, 3161.3993341265545, 3174.444472217399, 842.0695131879307, 870.2081106193334, 923.6351641101727, 966.227018385303, 1031.1235449867702, 28203.71796282052, 29048.0, 29264.853675731913, 29430.852845736063, 29463.558046629318, 874.8512752832033, 926.7451450850936, 981.6809536900536, 995.0944640377367, 1003.9809593262844, 14993.475228366955, 15352.846471535366, 15540.533783986499, 15556.688866222612, 15651.452199172974, 403163.0, 425102.0, 436162.0, 438409.0, 660518.0, 50583.0, 50677.746611267445, 50911.74544127256, 51051.48948510467, 51336.229956550684, 1162.7325715085578, 1174.0372894226653, 1181.2794195540714, 1187.8693343732182, 1194.9820752688718, 28188.859055705412, 29551.408971820012, 29660.851695741385, 29990.0, 30430.543541846448, 42966.57033429751, 43126.568734312255, 43674.34488482739, 43681.56318436775, 43796.56203437925, 357940.0, 359379.0, 360776.0, 360887.0, 361156.0, 23656.881715591313, 24468.265952020756, 24504.509909802062, 25426.0, 26020.609690854275, 39370.40944385894, 39556.60443395529, 39951.600483994785, 40166.6874610106, 40544.18911621692, 32247.677523225408, 32510.67489325171, 32563.511547326336, 32688.83655581707, 32916.50625240671, 34396.31207375888, 35169.0, 35202.47196292109, 35393.29213415769, 35440.11399715028, 33094.66905330916, 34582.48126278057, 35009.474857876645, 35917.28165436729, 36526.0, 32790.672093278765, 34126.0, 34147.14632134217, 34229.65770342265, 34232.14419639529, 26095.0, 26440.471190575696, 26448.8677556611, 26568.202953911412, 26826.19521414361], "value": 16757.84911091202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.8754217337192, 375.75575875680806, 378.3549048871674, 379.18853653182214, 381.81481981239097, 16406.589835254126, 16644.500664980056, 17030.148492575383, 17442.47672569825, 17496.737548936777, 17226.483205503853, 17249.396271130514, 18085.09574521272, 18314.175862086206, 18320.816791832076, 5121.590272778169, 5254.395744489375, 5260.8684782880355, 5286.709230992294, 5287.947120528784, 5168.0, 5180.559652429548, 5209.661372010826, 5219.921701174486, 5224.555912747421, 5068.5691716204165, 5175.24958880962, 5181.326427564431, 5185.948140518603, 5202.713850738208, 5073.974630126844, 5115.437301896788, 5149.9485005149845, 5167.560757335631, 5182.481751824825, 4560.703554268962, 4651.88370290742, 4652.418447694038, 4662.813487460531, 4665.603423708989, 18451.44645660632, 19659.11533980974, 19679.40961771149, 20670.689939650918, 21266.893665531574, 1864.0959134819602, 1968.252064215589, 1981.4848139483695, 2113.006886763219, 2296.8966396512196, 9487.193588544982, 9565.713028609152, 9642.662506812298, 9675.903240967571, 9736.75658108546, 1707.137895362834, 1820.8270214329618, 1840.5030641726792, 1842.7143792712152, 1842.8986405747678, 70132.0, 75570.0, 85970.57014714948, 90594.54702726445, 90735.54632226862, 15851.682966340608, 16595.751063734053, 17035.659286814443, 17648.823511764975, 17963.101844907702, 30057.549136762966, 30112.84943575268, 30179.09462716122, 30391.69608303933, 30408.087757367313, 9108.544572771334, 9393.295502837178, 9470.100340467645, 9531.142197202285, 9624.326297159132, 7868.527888326718, 7968.12350641429, 8068.677252909818, 8072.878906816402, 8128.837423251502, 8597.097304783032, 8687.870576825098, 8750.0, 8914.28685705142, 8929.285657147413, 3031.5149576067724, 3344.2642618623863, 3465.5841299044278, 3533.318353182044, 3643.049130204543, 756.9394448444111, 847.4237518487488, 892.054422312351, 926.1664501948301, 959.9904000959901, 17141.57146071358, 17287.394941176997, 17371.65256694859, 17868.9106554469, 18035.72946405805, 815.1644564321617, 839.5046922315863, 878.9604467798964, 898.9775255618662, 914.3234006834895, 9578.616855325849, 9869.35849169816, 10008.549615267331, 10095.798084038279, 10246.897531024744, 281900.0, 285537.0, 286017.0, 374144.0, 377440.0, 59677.40322596719, 62378.37621623816, 79008.60495697599, 82462.0, 82724.0, 908.6774195160755, 938.3572253006712, 953.1183655118987, 954.4750387286964, 954.9856752148723, 15909.363625454853, 16166.838331617004, 16379.0, 16546.751798722787, 17066.48800535986, 37452.00383969222, 38078.80960595179, 38507.95666454982, 39170.2165956685, 39707.40438893477, 49844.25233621571, 51560.0, 51624.48375516347, 53131.73434132805, 53554.19668704895, 7540.8491830164185, 7788.571628560484, 7820.491668041559, 7841.215878412113, 8004.159563245776, 8901.821963560564, 12105.0, 12362.44369003415, 12496.0, 12655.367231638196, 10604.628837990942, 10876.619318323821, 10916.672499825017, 10919.56321747153, 10933.726656833325, 10323.432211228455, 10659.0, 10696.251262411557, 10878.45607719595, 10943.616973405893, 10445.791084178121, 10682.198835087554, 10789.352638841694, 10958.726031849268, 11416.486258118239, 7492.325690687864, 7945.324647404804, 8120.0, 8130.634121464666, 8244.422890397855, 9743.756406089904, 10437.68686939393, 10736.248462607542, 10899.618513351994, 10928.56285748593], "value": 9023.799816843777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.15858247178, 1411.879990200833, 1503.4587548482543, 1678.2615649114396, 1715.9313627454894, 6770.187577490696, 7534.0, 7655.425843061765, 8148.5518296493665, 8153.510789352643, 7705.691772329114, 7928.841423171533, 7929.722459713911, 8004.239597238253, 8019.518828870272, 2201.3395981205613, 2239.675247089171, 2239.6864438978555, 2244.7194100737406, 2246.9438264043365, 2229.4537838229658, 2233.15140246706, 2260.9095636174534, 2281.74900760917, 2290.7823756743164, 2245.247841972941, 2257.142285931352, 2258.954820903581, 2271.3299576624936, 2273.715785526809, 2228.1198926424136, 2237.8321625878043, 2241.1371621925596, 2245.528439027806, 2253.9406478954866, 2133.5306232628795, 2151.47288914217, 2159.751628562704, 2173.0981642618294, 2174.7716489768504, 8051.396145289127, 8087.95956020222, 8098.797530061736, 8153.510789352657, 8157.79605509867, 4572.359869618256, 4666.066786642651, 4674.252119660872, 4690.390249267608, 4706.058788242365, 2976.836274004929, 3100.5504201890826, 3182.740254419365, 3186.8087914725193, 3207.9679203208134, 1032.2774058159318, 1035.5805898611075, 1041.4792603698152, 1050.9527071281811, 1057.7144171073844, 10834.295770774874, 10852.782944341068, 10858.185636077247, 10887.292325998786, 10966.616168434066, 4150.771707556113, 4257.084726783756, 4366.934495982563, 4407.2507673695545, 4420.292753159479, 8874.64501419936, 8953.104689530996, 9032.051634578274, 9193.356465047382, 9293.0, 4685.086408150446, 4696.929546056812, 4711.340412342206, 4713.528647135259, 4744.525547445228, 3631.7276204284785, 4091.284025295561, 4149.2738770715005, 4223.113146239262, 4228.5982831630945, 3759.379702349082, 3803.258364618928, 3820.0449887528116, 3904.941425878614, 3909.3940439231396, 1226.3193927370396, 1252.0734656354414, 1259.6913756129807, 1261.9432125554188, 1270.4854533913779, 828.3042244514637, 829.3282441222628, 861.7759382560454, 864.740577826662, 881.8677198420288, 5007.724575148329, 5056.191009438546, 5074.340335756328, 5177.197534382177, 5293.523582877482, 393.6929195227727, 406.7864371205082, 407.08406086305814, 412.89264791154517, 415.5325259083531, 3538.2569660371096, 3616.9819150904077, 3640.6177351378255, 3663.8534458621357, 3698.519192504957, 9401.71794846142, 9665.951670241744, 9709.36889102206, 9723.465209413409, 9740.318177727491, 9706.514674266258, 9713.90286097144, 9718.368306060083, 9752.9024709752, 9788.853167202355, 7484.176740558534, 7534.773956781305, 7642.159362470124, 7651.234876512415, 7657.502262352929, 5205.973970130125, 5277.947220527745, 5310.230016647642, 5321.733913304397, 5403.0544654686055, 9121.817563648823, 9148.771280718036, 9165.0, 9189.540522973959, 9198.862017069616, 8581.785455363666, 8940.5082720451, 8960.32797540174, 9204.907950920406, 9211.76970575741, 6152.169457123231, 6681.1314529110905, 6928.93071069303, 6942.444604431735, 7081.716731330689, 7714.922850771645, 7725.5364678119495, 7737.14891361961, 7754.108277548155, 7794.961025194838, 6755.932440675727, 6885.518013739191, 6931.480138989697, 6948.200956890022, 7139.892901606376, 6733.225679046776, 6833.555818871758, 6844.828879278058, 6855.520113592001, 7127.2516385778745, 6372.713227904663, 6373.171487706569, 6413.2945376007665, 6416.358364163733, 6434.64609446485, 4477.395551600493, 4521.84173553924, 4568.246239370466, 4592.88517787058, 4625.329327247463, 4713.434387873477, 4764.071006153906, 4866.756662166807, 4867.464578896389, 4873.878153046202], "value": 4149.380083331094, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.32054236882277, 300.1939791659395, 302.0816717179774, 302.67311303791905, 307.38829728839613, 5215.86960325992, 5216.6087543434205, 5224.791008359661, 5237.10969135247, 5246.714554934042, 5076.771545280462, 5094.566961808251, 5120.385553733558, 5129.2306154076905, 5144.588432925367, 3806.6764325032336, 3903.7657740535515, 4006.659433948118, 4019.31671615826, 4022.255882661717, 4013.377926421395, 4015.4980627421573, 4019.296623090962, 4022.8189731462153, 4041.747058411902, 3952.308346039446, 3979.9851037985272, 4007.5391329996987, 4008.4388185654034, 4009.0, 3747.6065013173497, 3978.4827972363696, 3993.5407428145845, 4018.477597912282, 4032.0927791247027, 3459.6713312235547, 3460.0, 3461.930761384783, 3463.4458486642015, 3465.7350067225534, 5015.498450154992, 5039.874003149914, 5057.115004874132, 5083.135866902636, 5115.667481613683, 4292.806823692941, 4552.863414097583, 4566.26939689648, 4591.829083583665, 4597.3793537872625, 5334.386545547234, 5340.62615616907, 5344.9732751336, 5351.438098999588, 5369.24830523727, 3796.2976849282973, 3801.6958643308467, 3830.9616903830884, 3841.1754416652147, 3842.3083844907906, 5383.43473935235, 5676.432356764331, 5687.744051517691, 5688.459596338341, 5695.1741997410145, 3898.8050597470015, 3905.453236546886, 3916.3342231820657, 3926.1951299984007, 3931.5478719947, 3913.25648126855, 3933.4689816874356, 3969.226000929791, 3971.384435412516, 3983.0, 4491.595756381876, 4513.842015529441, 4529.184746745552, 4529.38853254813, 4533.252013417749, 5128.845635035633, 5402.756875940592, 5409.702466364309, 5417.859945321655, 5484.177373393943, 1351.1420248142501, 1354.9634529584876, 1370.5271681269946, 1376.1742954227584, 1379.496348979597, 847.2967437027253, 863.5250612163285, 879.9296056315608, 889.9065598112235, 890.799570096736, 4606.815727370935, 4629.953700462952, 4642.187617166982, 4653.906921861611, 4658.114958158007, 5443.891122177613, 5470.9452905471235, 5474.178873169057, 5493.972530137404, 5506.752196151183, 4568.898306778852, 4627.259638457831, 4682.869294471007, 4688.437387513521, 4694.366260554782, 2898.6086878271162, 2915.6646985596926, 2915.795894287422, 2919.255589824581, 2941.8379740003006, 5084.542391184811, 5094.465081166498, 5099.5410413063, 5118.513741194581, 5131.435542090367, 5364.8122315718765, 5563.025126080264, 5574.554035677136, 5601.747921343549, 5603.747831347518, 5065.13892638245, 5076.857707015892, 5085.262636917626, 5109.3905419792645, 5128.69227846323, 5460.972695136499, 5462.180672899097, 5465.289512363367, 5483.341998959991, 5489.64317319373, 5257.7371131442505, 5367.329083864517, 5368.677879327252, 5372.570194384518, 5426.755795989269, 5090.0, 5097.7706003229205, 5099.311592934906, 5111.948880511147, 5160.664556803796, 3819.942700859545, 3824.7322687411615, 3847.0, 3867.0912335601674, 3881.1073453105378, 5300.867478313073, 5355.651882627617, 5454.1365782962675, 5496.80761173357, 5511.311086114236, 5265.4997775211295, 5274.525292723673, 5326.414094449685, 5343.7862485500145, 5354.973225134006, 5156.1492353761205, 5252.527272545489, 5261.131913234273, 5298.761555730079, 5303.602229832701, 5219.817306394258, 5221.060209162387, 5232.319798426181, 5232.476752324889, 5270.443834740225, 5104.285400044071, 5193.76628051731, 5330.227117068081, 5380.569554435714, 5410.59420543453, 5276.314079169683, 5277.630565860506, 5277.762500687555, 5303.817709374344, 5309.973450132725], "value": 4012.5183082496974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.6849822341494, 687.0861753867354, 687.2646268492708, 736.887300176733, 738.8522295540893, 12616.936915315422, 13386.531471398503, 13420.463181472755, 13432.126911750742, 13473.663158421032, 12244.510219591228, 12640.873591264084, 12849.743005139915, 13073.803892941589, 13207.273599952, 772.1814876231199, 788.2117882117882, 789.9802504937365, 790.7113903425266, 792.2829838995689, 780.3679019993823, 782.295933659708, 782.9843403131963, 783.4946459533597, 786.7875673568133, 809.4050872608628, 815.254042551065, 820.4748960665149, 820.9671613135467, 821.1706176761454, 817.0440584516131, 818.3085292927497, 818.6520728690283, 822.9588520574007, 823.8970128733908, 596.8418369132183, 597.5428796970322, 600.4595863722684, 602.2832828933555, 604.5163868904858, 11675.824862627067, 11689.0, 11747.47136378865, 11749.060075193964, 11790.0, 10865.727456723554, 11004.889951100467, 11121.110311175087, 11132.888671113265, 11392.943035284854, 9714.61141554337, 9810.754731131707, 9826.950865245699, 9967.950160249226, 10244.180465562811, 4222.873313800591, 4232.386303985905, 4249.490061192646, 4264.6801489888385, 4310.4611923509565, 40317.193656126714, 43585.56414435847, 59341.0, 59527.70236148835, 60016.69991650058, 9815.36200146988, 9942.701718948443, 9979.151772099307, 10169.694909152737, 10265.384076955406, 17331.4800555981, 17425.738613920803, 17496.825031749773, 17612.647747044986, 17675.381361652282, 6619.5035372347265, 6651.600903945779, 6665.100211471389, 6787.592744435349, 6793.932060679429, 3465.6187819339852, 3491.877784277538, 3561.3411518869093, 3597.8201089945924, 3609.7653652512504, 2895.7683385329124, 2986.074316961749, 2986.7759918006236, 3452.37857185704, 3644.799536025544, 591.7899145803264, 598.7604958016741, 598.8980276291558, 598.9011813050798, 607.884501944629, 535.5929493584904, 557.9609427340047, 580.9767609295666, 644.5649186798892, 645.6739346629922, 8619.0, 9116.954415227881, 9748.805023899624, 9775.951120244354, 9962.252831037702, 570.9854438226452, 577.7053702611698, 614.8370681769335, 623.5635055461196, 635.5836926812945, 4026.255142798533, 4100.302948498763, 4151.14901445203, 4195.706300558932, 4265.616094551505, 56487.15269270964, 56488.0, 56807.715961419926, 78870.6056469714, 94829.0, 66738.66630666815, 75747.62126189334, 81575.59212203902, 85934.0, 88505.55747221223, 49447.50552494501, 67085.0, 69194.0, 78721.60639196882, 79077.60461197772, 8708.960897630315, 9062.501562413867, 9157.31320150978, 9172.266218702354, 9210.309226808151, 33034.339313214085, 40012.399814003395, 41272.587274126876, 45163.09673806571, 45884.54115458803, 60423.697881510314, 61019.0, 62621.0, 67512.3248767506, 68825.0, 10952.39761813076, 10957.452127393439, 11126.165537584875, 11134.665960021212, 11136.832947505956, 12886.67783305425, 13466.93266533661, 13514.797278041035, 13664.65838354049, 13767.449302027806, 11061.446927653746, 11083.501242443948, 11122.538642808528, 11133.721656958642, 11876.584319548774, 11648.791705489526, 11775.823362649397, 11995.0, 12130.514779408724, 12539.811902821282, 12243.938780306042, 12325.198862073936, 12489.93755031219, 12763.361831908553, 12885.0, 9242.537873106452, 9256.0, 9454.149126578366, 9457.905420945977, 9591.952040239754, 9409.764755881159, 9806.0, 9840.655577055055, 9855.655052073143, 10040.347377420445], "value": 6514.254197944339, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 110.0, 118.0, 114.0, 114.0, 113.0, 114.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 157.0, 189.0, 124.0, 151.0, 144.0, 125.0, 182.0, 121.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 169.0, 167.0, 168.0, 162.0, 164.0, 161.0, 165.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 154.0, 77.0, 77.0, 75.0, 75.0, 169.0, 79.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 137.0, 87.0, 86.0, 88.0, 137.0, 86.0, 85.0, 141.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 117.0, 117.0, 117.0, 118.0, 120.0, 117.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 149.0, 150.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 67.0, 66.0, 65.0, 67.0, 69.0, 67.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 67.0, 67.0, 68.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 79.0, 86.0, 80.0, 80.0, 85.0, 85.0, 88.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 129.0, 141.0, 140.0, 131.0, 131.0, 131.0, 187.0, 132.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 173.0, 173.0, 176.0, 175.0, 175.0, 176.0, 181.0, 175.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 70.0, 68.0, 72.0, 70.0, 68.0, 66.0, 67.0, 68.0], "value": 69.3, "unit": "score"}]}]} 05:51:20 INFO - Return code: 0 05:51:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:51:20 ERROR - # TBPL SUCCESS # 05:51:20 INFO - Running post-action listener: _resource_record_post_action 05:51:20 INFO - ##### 05:51:20 INFO - ##### Finished run-tests step (success) 05:51:20 INFO - ##### 05:51:20 INFO - Running post-run listener: _resource_record_post_run 05:51:20 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7970816; Write bytes: 417271808; Read time: 1196; Write time: 441044 05:51:20 INFO - TinderboxPrint: CPU usage
13.3% 05:51:20 INFO - TinderboxPrint: I/O read bytes / time
7,970,816 / 1,196 05:51:20 INFO - TinderboxPrint: I/O write bytes / time
417,271,808 / 441,044 05:51:20 INFO - TinderboxPrint: CPU idle
8,300.7 (86.7%) 05:51:20 INFO - TinderboxPrint: CPU user
1,217.5 (12.7%) 05:51:20 INFO - TinderboxPrint: Swap in / out
0 / 0 05:51:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 43552768; Read time: 0; Write time: 17904 05:51:20 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5685248; Write bytes: 324939776; Read time: 920; Write time: 348316 05:51:21 INFO - Running post-run listener: _upload_blobber_files 05:51:21 INFO - Blob upload gear active. 05:51:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:51:21 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 05:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:51:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:22 INFO - (blobuploader) - INFO - Done attempting. 05:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:22 INFO - (blobuploader) - INFO - Done attempting. 05:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:26 INFO - (blobuploader) - INFO - Done attempting. 05:51:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:26 INFO - Return code: 0 05:51:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e8ce87667e266fc3574639d53f022d8b9f452b44ad4fb789931a0587095d62432001bdcaf1bf0ed1bd573a66e7361e4b1a3f2d1e65fb0397cf743cd70ff0e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5a6509dfeaf3faf8bba5d71cf5d24f7bdcfe1d2835aaa16fb494a98266eca9a1e2a75df16011193148f590ee37287e1ee2bb37157b39e61b0eebb1d9ed44701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0a85252095edaf943b770ae4b5fd8756715c27bb41e663caf70f8c77e54c4377c98ac7548e66200412cca5162dc0cc34b491b75132f9be2d8cbc467dd37e117"} 05:51:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:26 INFO - Contents: 05:51:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e8ce87667e266fc3574639d53f022d8b9f452b44ad4fb789931a0587095d62432001bdcaf1bf0ed1bd573a66e7361e4b1a3f2d1e65fb0397cf743cd70ff0e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5a6509dfeaf3faf8bba5d71cf5d24f7bdcfe1d2835aaa16fb494a98266eca9a1e2a75df16011193148f590ee37287e1ee2bb37157b39e61b0eebb1d9ed44701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0a85252095edaf943b770ae4b5fd8756715c27bb41e663caf70f8c77e54c4377c98ac7548e66200412cca5162dc0cc34b491b75132f9be2d8cbc467dd37e117"} 05:51:26 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:26 INFO - Copying logs to upload dir... 05:51:26 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.462981 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-04 05:51:26.467627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 05:51:26.471472) ========= 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=7de08804244eb36560b44971000001c3-1467631106.260491-1974037232 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/Firefox-Non-PGO/sha512/1e8ce87667e266fc3574639d53f022d8b9f452b44ad4fb789931a0587095d62432001bdcaf1bf0ed1bd573a66e7361e4b1a3f2d1e65fb0397cf743cd70ff0e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5a6509dfeaf3faf8bba5d71cf5d24f7bdcfe1d2835aaa16fb494a98266eca9a1e2a75df16011193148f590ee37287e1ee2bb37157b39e61b0eebb1d9ed44701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0a85252095edaf943b770ae4b5fd8756715c27bb41e663caf70f8c77e54c4377c98ac7548e66200412cca5162dc0cc34b491b75132f9be2d8cbc467dd37e117"} build_url:https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/A1k80cCjQvy56Q_EuG2fzw/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/Firefox-Non-PGO/sha512/1e8ce87667e266fc3574639d53f022d8b9f452b44ad4fb789931a0587095d62432001bdcaf1bf0ed1bd573a66e7361e4b1a3f2d1e65fb0397cf743cd70ff0e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5a6509dfeaf3faf8bba5d71cf5d24f7bdcfe1d2835aaa16fb494a98266eca9a1e2a75df16011193148f590ee37287e1ee2bb37157b39e61b0eebb1d9ed44701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0a85252095edaf943b770ae4b5fd8756715c27bb41e663caf70f8c77e54c4377c98ac7548e66200412cca5162dc0cc34b491b75132f9be2d8cbc467dd37e117"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 05:51:26.497128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:51:26.497502) ========= 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=7de08804244eb36560b44971000001c3-1467631106.260491-1974037232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:51:26.582134) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 05:51:26.582500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 05:51:26.582817) ========= ========= Total master_lag: 0.18 =========