builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1468313625.94 results: success (0) buildid: 20160712005526 builduid: 33555fc9d27c47ab9d185a8a8f35c500 revision: 0d13d82daefda68120e464c2428a0f1124f2f780 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:45.935341) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:45.935806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:45.936079) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:45.952709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:45.953081) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 01:53:47-- 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% 50.5M=0s 2016-07-12 01:53:47 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:46.058145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:46.058454) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016700 ========= master_lag: 0.40 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:46.478012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 01:53:46.478384) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d13d82daefda68120e464c2428a0f1124f2f780 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0d13d82daefda68120e464c2428a0f1124f2f780 --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=a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 01:53:48,070 truncating revision to first 12 chars 2016-07-12 01:53:48,070 Setting DEBUG logging. 2016-07-12 01:53:48,070 attempt 1/10 2016-07-12 01:53:48,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d13d82daefd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 01:53:49,113 unpacking tar archive at: fx-team-0d13d82daefd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.419765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 01:53:47.915580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:47.915897) ========= script_repo_revision: 0d13d82daefda68120e464c2428a0f1124f2f780 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:47.916281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:47.916557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 01:53:47.930650) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-12 01:53:47.931028) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:53:49 INFO - MultiFileLogger online at 20160712 01:53:49 in /builds/slave/test 01:53:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:53:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:53:49 INFO - {'append_to_log': False, 01:53:49 INFO - 'base_work_dir': '/builds/slave/test', 01:53:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:53:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:53:49 INFO - 'branch': 'Fx-Team-Non-PGO', 01:53:49 INFO - 'buildbot_json_path': 'buildprops.json', 01:53:49 INFO - 'config_files': ('talos/linux_config.py',), 01:53:49 INFO - 'default_actions': ('clobber', 01:53:49 INFO - 'read-buildbot-config', 01:53:49 INFO - 'download-and-extract', 01:53:49 INFO - 'populate-webroot', 01:53:49 INFO - 'create-virtualenv', 01:53:49 INFO - 'install', 01:53:49 INFO - 'run-tests'), 01:53:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:53:49 INFO - 'download_minidump_stackwalk': True, 01:53:49 INFO - 'download_symbols': 'ondemand', 01:53:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:53:49 INFO - 'tooltool.py': '/tools/tooltool.py', 01:53:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:53:49 INFO - '/tools/misc-python/virtualenv.py')}, 01:53:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:53:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:53:49 INFO - 'installer_path': 'installer.exe', 01:53:49 INFO - 'log_level': 'info', 01:53:49 INFO - 'log_name': 'talos', 01:53:49 INFO - 'log_to_console': True, 01:53:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:53:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:53:49 INFO - 'opt_config_files': (), 01:53:49 INFO - 'pip_index': False, 01:53:49 INFO - 'sps_profile': False, 01:53:49 INFO - 'sps_profile_interval': 0, 01:53:49 INFO - 'suite': 'dromaeojs-e10s', 01:53:49 INFO - 'system_bits': '32', 01:53:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:53:49 INFO - 'title': 'talos-linux64-ix-064', 01:53:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:53:49 INFO - 'use_talos_json': True, 01:53:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:53:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:53:49 INFO - 'work_dir': 'build'} 01:53:49 INFO - ##### 01:53:49 INFO - ##### Running clobber step. 01:53:49 INFO - ##### 01:53:49 INFO - Running pre-action listener: _resource_record_pre_action 01:53:49 INFO - Running main action method: clobber 01:53:49 INFO - rmtree: /builds/slave/test/build 01:53:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:53:50 INFO - Running post-action listener: _resource_record_post_action 01:53:50 INFO - ##### 01:53:50 INFO - ##### Finished clobber step (success) 01:53:50 INFO - ##### 01:53:50 INFO - ##### 01:53:50 INFO - ##### Running read-buildbot-config step. 01:53:50 INFO - ##### 01:53:50 INFO - Running pre-action listener: _resource_record_pre_action 01:53:50 INFO - Running main action method: read_buildbot_config 01:53:50 INFO - Using buildbot properties: 01:53:50 INFO - { 01:53:50 INFO - "project": "", 01:53:50 INFO - "product": "firefox", 01:53:50 INFO - "script_repo_revision": "production", 01:53:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:53:50 INFO - "repository": "", 01:53:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:53:50 INFO - "buildid": "20160712005526", 01:53:50 INFO - "pgo_build": "False", 01:53:50 INFO - "basedir": "/builds/slave/test", 01:53:50 INFO - "buildnumber": 1445, 01:53:50 INFO - "slavename": "talos-linux64-ix-064", 01:53:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:53:50 INFO - "platform": "ubuntu64_hw", 01:53:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:53:50 INFO - "branch": "fx-team", 01:53:50 INFO - "repo_path": "integration/fx-team", 01:53:50 INFO - "revision": "0d13d82daefda68120e464c2428a0f1124f2f780", 01:53:50 INFO - "stage_platform": "linux64", 01:53:50 INFO - "builduid": "33555fc9d27c47ab9d185a8a8f35c500", 01:53:50 INFO - "slavebuilddir": "test" 01:53:50 INFO - } 01:53:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:53:50 INFO - Running post-action listener: _resource_record_post_action 01:53:50 INFO - ##### 01:53:50 INFO - ##### Finished read-buildbot-config step (success) 01:53:50 INFO - ##### 01:53:50 INFO - ##### 01:53:50 INFO - ##### Running download-and-extract step. 01:53:50 INFO - ##### 01:53:50 INFO - Running pre-action listener: _resource_record_pre_action 01:53:50 INFO - Running main action method: download_and_extract 01:53:50 INFO - mkdir: /builds/slave/test/build/tests 01:53: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')]} 01:53:50 INFO - https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:53:51 INFO - Downloaded 1361 bytes. 01:53:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:53:51 INFO - Using the following test package requirements: 01:53:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:53:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:53:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'jsshell-linux-x86_64.zip'], 01:53:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:53:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:53:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:53:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:53:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:53:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:51 INFO - https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:53:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:53:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:53:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:52 INFO - Downloaded 22700380 bytes. 01:53:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:53:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:53:53 INFO - Return code: 0 01:53:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:53: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')]} 01:53:53 INFO - https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:53:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:53:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:54 INFO - Downloaded 22700380 bytes. 01:53:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:53:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:53:56 INFO - Return code: 0 01:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:56 INFO - https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:53:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:53:57 INFO - Downloaded 14403333 bytes. 01:53:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:53:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:53:57 INFO - Return code: 0 01:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:57 INFO - https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:53:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:53:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:53:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:53:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:53:58 INFO - Downloaded 56653613 bytes. 01:53:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:53:58 INFO - mkdir: /builds/slave/test/properties 01:53:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:53:58 INFO - Writing to file /builds/slave/test/properties/build_url 01:53:58 INFO - Contents: 01:53:58 INFO - build_url:https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:53:59 INFO - Running post-action listener: _resource_record_post_action 01:53:59 INFO - Running post-action listener: set_extra_try_arguments 01:53:59 INFO - ##### 01:53:59 INFO - ##### Finished download-and-extract step (success) 01:53:59 INFO - ##### 01:53:59 INFO - ##### 01:53:59 INFO - ##### Running populate-webroot step. 01:53:59 INFO - ##### 01:53:59 INFO - Running pre-action listener: _resource_record_pre_action 01:53:59 INFO - Running main action method: populate_webroot 01:53:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:53:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:53:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:53:59 INFO - '--tppagecycles', 01:53:59 INFO - '7'], 01:53:59 INFO - 'tests': ['tsvgm']}}, 01:53:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:53:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:53:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:53:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:53:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['damp', 'tps']}, 01:53:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'tests': ['damp', 'tps']}, 01:53:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['dromaeo_dom']}, 01:53:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:53:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['basic_compositor_video']}, 01:53:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:53:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['a11yr', 01:53:59 INFO - 'ts_paint', 01:53:59 INFO - 'tpaint', 01:53:59 INFO - 'sessionrestore', 01:53:59 INFO - 'sessionrestore_no_auto_restore', 01:53:59 INFO - 'tabpaint']}, 01:53:59 INFO - 'other-e10s': {'tests': ['a11yr', 01:53:59 INFO - 'ts_paint', 01:53:59 INFO - 'tpaint', 01:53:59 INFO - 'sessionrestore', 01:53:59 INFO - 'sessionrestore_no_auto_restore', 01:53:59 INFO - 'tabpaint']}, 01:53:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:53:59 INFO - 'ts_paint', 01:53:59 INFO - 'tpaint', 01:53:59 INFO - 'sessionrestore', 01:53:59 INFO - 'sessionrestore_no_auto_restore', 01:53:59 INFO - 'tabpaint']}, 01:53:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:53:59 INFO - 'ts_paint', 01:53:59 INFO - 'tpaint', 01:53:59 INFO - 'sessionrestore', 01:53:59 INFO - 'sessionrestore_no_auto_restore', 01:53:59 INFO - 'tabpaint']}, 01:53:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['a11yr', 01:53:59 INFO - 'ts_paint', 01:53:59 INFO - 'tpaint', 01:53:59 INFO - 'sessionrestore', 01:53:59 INFO - 'sessionrestore_no_auto_restore', 01:53:59 INFO - 'tabpaint']}, 01:53:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['a11yr', 01:53:59 INFO - 'ts_paint', 01:53:59 INFO - 'tpaint', 01:53:59 INFO - 'sessionrestore', 01:53:59 INFO - 'sessionrestore_no_auto_restore', 01:53:59 INFO - 'tabpaint']}, 01:53:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['tsvgx', 01:53:59 INFO - 'tsvgr_opacity', 01:53:59 INFO - 'tart', 01:53:59 INFO - 'tscrollx', 01:53:59 INFO - 'cart']}, 01:53:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:53:59 INFO - 'tsvgr_opacity', 01:53:59 INFO - 'tart', 01:53:59 INFO - 'tscrollx', 01:53:59 INFO - 'cart']}, 01:53:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'talos_options': ['--disable-e10s'], 01:53:59 INFO - 'tests': ['tp5o']}, 01:53:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'tests': ['tp5o']}, 01:53:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'talos_options': ['--disable-e10s', 01:53:59 INFO - '--xperf_path', 01:53:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:59 INFO - 'tests': ['tp5n']}, 01:53:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:59 INFO - 'talos_options': ['--xperf_path', 01:53:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:59 INFO - 'tests': ['tp5n']}}, 01:53:59 INFO - 'talos.zip': {'path': '', 01:53:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:53:59 INFO - Running post-action listener: _resource_record_post_action 01:53:59 INFO - ##### 01:53:59 INFO - ##### Finished populate-webroot step (success) 01:53:59 INFO - ##### 01:53:59 INFO - ##### 01:53:59 INFO - ##### Running create-virtualenv step. 01:53:59 INFO - ##### 01:53:59 INFO - Running pre-action listener: _resource_record_pre_action 01:53:59 INFO - Running main action method: create_virtualenv 01:53:59 INFO - Creating virtualenv /builds/slave/test/build/venv 01:53:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:53:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:53:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:53:59 INFO - Using real prefix '/usr' 01:53:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:54:00 INFO - Installing distribute.............................................................................................................................................................................................done. 01:54:02 INFO - Installing pip.................done. 01:54:02 INFO - Return code: 0 01:54:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:54:02 INFO - Using env: {'DISPLAY': ':0', 01:54:02 INFO - 'HOME': '/home/cltbld', 01:54:02 INFO - 'LANG': 'en_US.UTF-8', 01:54:02 INFO - 'LANGUAGE': 'en_US:en', 01:54:02 INFO - 'LOGNAME': 'cltbld', 01:54:02 INFO - 'MAIL': '/var/mail/cltbld', 01:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:02 INFO - 'MOZ_NO_REMOTE': '1', 01:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:02 INFO - 'NO_EM_RESTART': '1', 01:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:02 INFO - 'PWD': '/builds/slave/test', 01:54:02 INFO - 'SHELL': '/bin/bash', 01:54:02 INFO - 'SHLVL': '1', 01:54:02 INFO - 'TERM': 'linux', 01:54:02 INFO - 'TMOUT': '86400', 01:54:02 INFO - 'USER': 'cltbld', 01:54:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:02 INFO - '_': '/tools/buildbot/bin/python'} 01:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:54:02 INFO - Cleaning up... 01:54:02 INFO - Return code: 0 01:54:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:54:02 INFO - Using env: {'DISPLAY': ':0', 01:54:02 INFO - 'HOME': '/home/cltbld', 01:54:02 INFO - 'LANG': 'en_US.UTF-8', 01:54:02 INFO - 'LANGUAGE': 'en_US:en', 01:54:02 INFO - 'LOGNAME': 'cltbld', 01:54:02 INFO - 'MAIL': '/var/mail/cltbld', 01:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:02 INFO - 'MOZ_NO_REMOTE': '1', 01:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:02 INFO - 'NO_EM_RESTART': '1', 01:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:02 INFO - 'PWD': '/builds/slave/test', 01:54:02 INFO - 'SHELL': '/bin/bash', 01:54:02 INFO - 'SHLVL': '1', 01:54:02 INFO - 'TERM': 'linux', 01:54:02 INFO - 'TMOUT': '86400', 01:54:02 INFO - 'USER': 'cltbld', 01:54:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:02 INFO - '_': '/tools/buildbot/bin/python'} 01:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:02 INFO - Downloading/unpacking psutil>=3.1.1 01:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:54:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:54:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:54:04 INFO - Installing collected packages: psutil 01:54:04 INFO - Running setup.py install for psutil 01:54:04 INFO - building 'psutil._psutil_linux' extension 01:54:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:54:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:54:04 INFO - building 'psutil._psutil_posix' extension 01:54:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:54:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:54:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:54:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:54:05 INFO - Successfully installed psutil 01:54:05 INFO - Cleaning up... 01:54:05 INFO - Return code: 0 01:54:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:05 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 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:54:05 INFO - Using env: {'DISPLAY': ':0', 01:54:05 INFO - 'HOME': '/home/cltbld', 01:54:05 INFO - 'LANG': 'en_US.UTF-8', 01:54:05 INFO - 'LANGUAGE': 'en_US:en', 01:54:05 INFO - 'LOGNAME': 'cltbld', 01:54:05 INFO - 'MAIL': '/var/mail/cltbld', 01:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:05 INFO - 'MOZ_NO_REMOTE': '1', 01:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:05 INFO - 'NO_EM_RESTART': '1', 01:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:05 INFO - 'PWD': '/builds/slave/test', 01:54:05 INFO - 'SHELL': '/bin/bash', 01:54:05 INFO - 'SHLVL': '1', 01:54:05 INFO - 'TERM': 'linux', 01:54:05 INFO - 'TMOUT': '86400', 01:54:05 INFO - 'USER': 'cltbld', 01:54:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:05 INFO - '_': '/tools/buildbot/bin/python'} 01:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:54:07 INFO - Installing collected packages: mozsystemmonitor 01:54:07 INFO - Running setup.py install for mozsystemmonitor 01:54:07 INFO - Successfully installed mozsystemmonitor 01:54:07 INFO - Cleaning up... 01:54:07 INFO - Return code: 0 01:54:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 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 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:54:07 INFO - Using env: {'DISPLAY': ':0', 01:54:07 INFO - 'HOME': '/home/cltbld', 01:54:07 INFO - 'LANG': 'en_US.UTF-8', 01:54:07 INFO - 'LANGUAGE': 'en_US:en', 01:54:07 INFO - 'LOGNAME': 'cltbld', 01:54:07 INFO - 'MAIL': '/var/mail/cltbld', 01:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:07 INFO - 'MOZ_NO_REMOTE': '1', 01:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:07 INFO - 'NO_EM_RESTART': '1', 01:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:07 INFO - 'PWD': '/builds/slave/test', 01:54:07 INFO - 'SHELL': '/bin/bash', 01:54:07 INFO - 'SHLVL': '1', 01:54:07 INFO - 'TERM': 'linux', 01:54:07 INFO - 'TMOUT': '86400', 01:54:07 INFO - 'USER': 'cltbld', 01:54:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:07 INFO - '_': '/tools/buildbot/bin/python'} 01:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:07 INFO - Downloading/unpacking jsonschema==2.5.1 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:54:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:54:09 INFO - warning: no files found matching '*.txt' 01:54:09 INFO - no previously-included directories found matching 'build' 01:54:09 INFO - no previously-included directories found matching 'dist' 01:54:09 INFO - no previously-included directories found matching '.git*' 01:54:09 INFO - Installing collected packages: jsonschema, functools32 01:54:10 INFO - Running setup.py install for functools32 01:54:10 INFO - warning: no files found matching '*.txt' 01:54:10 INFO - no previously-included directories found matching 'build' 01:54:10 INFO - no previously-included directories found matching 'dist' 01:54:10 INFO - no previously-included directories found matching '.git*' 01:54:10 INFO - Successfully installed jsonschema functools32 01:54:10 INFO - Cleaning up... 01:54:10 INFO - Return code: 0 01:54:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:10 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 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:54:10 INFO - Using env: {'DISPLAY': ':0', 01:54:10 INFO - 'HOME': '/home/cltbld', 01:54:10 INFO - 'LANG': 'en_US.UTF-8', 01:54:10 INFO - 'LANGUAGE': 'en_US:en', 01:54:10 INFO - 'LOGNAME': 'cltbld', 01:54:10 INFO - 'MAIL': '/var/mail/cltbld', 01:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:10 INFO - 'MOZ_NO_REMOTE': '1', 01:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:10 INFO - 'NO_EM_RESTART': '1', 01:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:10 INFO - 'PWD': '/builds/slave/test', 01:54:10 INFO - 'SHELL': '/bin/bash', 01:54:10 INFO - 'SHLVL': '1', 01:54:10 INFO - 'TERM': 'linux', 01:54:10 INFO - 'TMOUT': '86400', 01:54:10 INFO - 'USER': 'cltbld', 01:54:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:10 INFO - '_': '/tools/buildbot/bin/python'} 01:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:10 INFO - Downloading/unpacking blobuploader==1.2.4 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:12 INFO - Downloading blobuploader-1.2.4.tar.gz 01:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:54:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:54:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:12 INFO - Downloading docopt-0.6.1.tar.gz 01:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:54:13 INFO - Installing collected packages: blobuploader, requests, docopt 01:54:13 INFO - Running setup.py install for blobuploader 01:54:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:54:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:54:13 INFO - Running setup.py install for requests 01:54:13 INFO - Running setup.py install for docopt 01:54:13 INFO - Successfully installed blobuploader requests docopt 01:54:13 INFO - Cleaning up... 01:54:13 INFO - Return code: 0 01:54:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:13 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 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:54:13 INFO - Using env: {'DISPLAY': ':0', 01:54:13 INFO - 'HOME': '/home/cltbld', 01:54:13 INFO - 'LANG': 'en_US.UTF-8', 01:54:13 INFO - 'LANGUAGE': 'en_US:en', 01:54:13 INFO - 'LOGNAME': 'cltbld', 01:54:13 INFO - 'MAIL': '/var/mail/cltbld', 01:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:13 INFO - 'MOZ_NO_REMOTE': '1', 01:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:13 INFO - 'NO_EM_RESTART': '1', 01:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:13 INFO - 'PWD': '/builds/slave/test', 01:54:13 INFO - 'SHELL': '/bin/bash', 01:54:13 INFO - 'SHLVL': '1', 01:54:13 INFO - 'TERM': 'linux', 01:54:13 INFO - 'TMOUT': '86400', 01:54:13 INFO - 'USER': 'cltbld', 01:54:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:13 INFO - '_': '/tools/buildbot/bin/python'} 01:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:54:13 INFO - Running setup.py (path:/tmp/pip-n01Nfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:54:13 INFO - Running setup.py (path:/tmp/pip-f_wm7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:54:13 INFO - Running setup.py (path:/tmp/pip-36tOOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:54:14 INFO - Running setup.py (path:/tmp/pip-pg7bs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:54:14 INFO - Running setup.py (path:/tmp/pip-YLzcwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:54:14 INFO - Running setup.py (path:/tmp/pip-vLMmyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:54:14 INFO - Running setup.py (path:/tmp/pip-TkVqmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:54:14 INFO - Running setup.py (path:/tmp/pip-VvMkMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:54:14 INFO - Running setup.py (path:/tmp/pip-MJi_MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:54:14 INFO - Running setup.py (path:/tmp/pip-nWtwJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:54:14 INFO - Running setup.py (path:/tmp/pip-_L_Mch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:54:14 INFO - Running setup.py (path:/tmp/pip-Y0h5_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:54:14 INFO - Running setup.py (path:/tmp/pip-cyvzZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:54:14 INFO - Running setup.py (path:/tmp/pip-eAV9Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:14 INFO - Running setup.py (path:/tmp/pip-Nr6z2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:54:14 INFO - Running setup.py (path:/tmp/pip-TZFhZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:54:14 INFO - Running setup.py (path:/tmp/pip-EleswU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:54:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:54:15 INFO - Running setup.py install for manifestparser 01:54:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Running setup.py install for mozcrash 01:54:15 INFO - Running setup.py install for mozdebug 01:54:15 INFO - Running setup.py install for mozdevice 01:54:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Running setup.py install for mozfile 01:54:15 INFO - Running setup.py install for mozhttpd 01:54:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Running setup.py install for mozinfo 01:54:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Running setup.py install for mozInstall 01:54:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:54:15 INFO - Running setup.py install for mozleak 01:54:15 INFO - Running setup.py install for mozlog 01:54:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:54:16 INFO - Running setup.py install for moznetwork 01:54:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:54:16 INFO - Running setup.py install for mozprocess 01:54:16 INFO - Running setup.py install for mozprofile 01:54:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:54:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:54:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:54:16 INFO - Running setup.py install for mozrunner 01:54:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:54:16 INFO - Running setup.py install for mozscreenshot 01:54:16 INFO - Running setup.py install for moztest 01:54:16 INFO - Running setup.py install for mozversion 01:54:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:54:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:54:16 INFO - Cleaning up... 01:54:16 INFO - Return code: 0 01:54:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:16 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 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:54:16 INFO - Using env: {'DISPLAY': ':0', 01:54:16 INFO - 'HOME': '/home/cltbld', 01:54:16 INFO - 'LANG': 'en_US.UTF-8', 01:54:16 INFO - 'LANGUAGE': 'en_US:en', 01:54:16 INFO - 'LOGNAME': 'cltbld', 01:54:16 INFO - 'MAIL': '/var/mail/cltbld', 01:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:16 INFO - 'MOZ_NO_REMOTE': '1', 01:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:16 INFO - 'NO_EM_RESTART': '1', 01:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:16 INFO - 'PWD': '/builds/slave/test', 01:54:16 INFO - 'SHELL': '/bin/bash', 01:54:16 INFO - 'SHLVL': '1', 01:54:16 INFO - 'TERM': 'linux', 01:54:16 INFO - 'TMOUT': '86400', 01:54:16 INFO - 'USER': 'cltbld', 01:54:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:16 INFO - '_': '/tools/buildbot/bin/python'} 01:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:54:17 INFO - Running setup.py (path:/tmp/pip-wAY2kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:54:17 INFO - Running setup.py (path:/tmp/pip-IyO6Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:54:17 INFO - Running setup.py (path:/tmp/pip-pPdZFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:54:17 INFO - Running setup.py (path:/tmp/pip-wariOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:54:17 INFO - Running setup.py (path:/tmp/pip-_JdCCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:54:17 INFO - Running setup.py (path:/tmp/pip-ooYPnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:54:17 INFO - Running setup.py (path:/tmp/pip-axPw68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:54:17 INFO - Running setup.py (path:/tmp/pip-5qvBo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:54:17 INFO - Running setup.py (path:/tmp/pip-1rizqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:54:17 INFO - Running setup.py (path:/tmp/pip-2Diqol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:54:17 INFO - Running setup.py (path:/tmp/pip-kL2up4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:54:17 INFO - Running setup.py (path:/tmp/pip-F0b50P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:54:17 INFO - Running setup.py (path:/tmp/pip-9SK9gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:54:18 INFO - Running setup.py (path:/tmp/pip-oZUeip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:18 INFO - Running setup.py (path:/tmp/pip-u_zi86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:54:18 INFO - Running setup.py (path:/tmp/pip-ta4zoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:54:18 INFO - Running setup.py (path:/tmp/pip-i2oRD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:54:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:20 INFO - Downloading blessings-1.6.tar.gz 01:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:54:20 INFO - Installing collected packages: blessings 01:54:20 INFO - Running setup.py install for blessings 01:54:20 INFO - Successfully installed blessings 01:54:20 INFO - Cleaning up... 01:54:20 INFO - Return code: 0 01:54:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:54:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:54:20 INFO - Reading from file tmpfile_stdout 01:54:20 INFO - Current package versions: 01:54:20 INFO - argparse == 1.2.1 01:54:20 INFO - blessings == 1.6 01:54:20 INFO - blobuploader == 1.2.4 01:54:20 INFO - docopt == 0.6.1 01:54:20 INFO - functools32 == 3.2.3-2 01:54:20 INFO - jsonschema == 2.5.1 01:54:20 INFO - manifestparser == 1.1 01:54:20 INFO - mozInstall == 1.12 01:54:20 INFO - mozcrash == 0.17 01:54:20 INFO - mozdebug == 0.1 01:54:20 INFO - mozdevice == 0.48 01:54:20 INFO - mozfile == 1.2 01:54:20 INFO - mozhttpd == 0.7 01:54:20 INFO - mozinfo == 0.9 01:54:20 INFO - mozleak == 0.1 01:54:20 INFO - mozlog == 3.2 01:54:20 INFO - moznetwork == 0.27 01:54:20 INFO - mozprocess == 0.23 01:54:20 INFO - mozprofile == 0.28 01:54:20 INFO - mozrunner == 6.12 01:54:20 INFO - mozscreenshot == 0.1 01:54:20 INFO - mozsystemmonitor == 0.3 01:54:20 INFO - moztest == 0.7 01:54:20 INFO - mozversion == 1.4 01:54:20 INFO - psutil == 3.1.1 01:54:20 INFO - requests == 1.2.3 01:54:20 INFO - wsgiref == 0.1.2 01:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:20 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 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:54:20 INFO - Using env: {'DISPLAY': ':0', 01:54:20 INFO - 'HOME': '/home/cltbld', 01:54:20 INFO - 'LANG': 'en_US.UTF-8', 01:54:20 INFO - 'LANGUAGE': 'en_US:en', 01:54:20 INFO - 'LOGNAME': 'cltbld', 01:54:20 INFO - 'MAIL': '/var/mail/cltbld', 01:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:20 INFO - 'MOZ_NO_REMOTE': '1', 01:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:20 INFO - 'NO_EM_RESTART': '1', 01:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:20 INFO - 'PWD': '/builds/slave/test', 01:54:20 INFO - 'SHELL': '/bin/bash', 01:54:20 INFO - 'SHLVL': '1', 01:54:20 INFO - 'TERM': 'linux', 01:54:20 INFO - 'TMOUT': '86400', 01:54:20 INFO - 'USER': 'cltbld', 01:54:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:20 INFO - '_': '/tools/buildbot/bin/python'} 01:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:54:20 INFO - Cleaning up... 01:54:20 INFO - Return code: 0 01:54:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b70400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:54:20 INFO - Using env: {'DISPLAY': ':0', 01:54:20 INFO - 'HOME': '/home/cltbld', 01:54:20 INFO - 'LANG': 'en_US.UTF-8', 01:54:20 INFO - 'LANGUAGE': 'en_US:en', 01:54:20 INFO - 'LOGNAME': 'cltbld', 01:54:20 INFO - 'MAIL': '/var/mail/cltbld', 01:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:20 INFO - 'MOZ_NO_REMOTE': '1', 01:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:20 INFO - 'NO_EM_RESTART': '1', 01:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:20 INFO - 'PWD': '/builds/slave/test', 01:54:20 INFO - 'SHELL': '/bin/bash', 01:54:20 INFO - 'SHLVL': '1', 01:54:20 INFO - 'TERM': 'linux', 01:54:20 INFO - 'TMOUT': '86400', 01:54:20 INFO - 'USER': 'cltbld', 01:54:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:20 INFO - '_': '/tools/buildbot/bin/python'} 01:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:54:21 INFO - Cleaning up... 01:54:21 INFO - Return code: 0 01:54:21 INFO - Running post-action listener: _resource_record_post_action 01:54:21 INFO - Running post-action listener: _start_resource_monitoring 01:54:21 INFO - Starting resource monitoring. 01:54:21 INFO - ##### 01:54:21 INFO - ##### Finished create-virtualenv step (success) 01:54:21 INFO - ##### 01:54:21 INFO - ##### 01:54:21 INFO - ##### Running install step. 01:54:21 INFO - ##### 01:54:21 INFO - Running pre-action listener: _resource_record_pre_action 01:54:21 INFO - Running main action method: install 01:54:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:54:21 INFO - Reading from file tmpfile_stdout 01:54:21 INFO - Detecting whether we're running mozinstall >=1.0... 01:54:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:54:21 INFO - Reading from file tmpfile_stdout 01:54:21 INFO - Output received: 01:54:21 INFO - Usage: mozinstall [options] installer 01:54:21 INFO - Options: 01:54:21 INFO - -h, --help show this help message and exit 01:54:21 INFO - -d DEST, --destination=DEST 01:54:21 INFO - Directory to install application into. [default: 01:54:21 INFO - "/builds/slave/test"] 01:54:21 INFO - --app=APP Application being installed. [default: firefox] 01:54:21 INFO - mkdir: /builds/slave/test/build/application 01:54:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:54:37 INFO - Reading from file tmpfile_stdout 01:54:37 INFO - Output received: 01:54:37 INFO - /builds/slave/test/build/application/firefox/firefox 01:54:37 INFO - Running post-action listener: _resource_record_post_action 01:54:37 INFO - ##### 01:54:37 INFO - ##### Finished install step (success) 01:54:37 INFO - ##### 01:54:37 INFO - ##### 01:54:37 INFO - ##### Running run-tests step. 01:54:37 INFO - ##### 01:54:37 INFO - Running pre-action listener: _resource_record_pre_action 01:54:37 INFO - Running main action method: run_tests 01:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:54:37 INFO - Python 2.7.3 01:54:37 INFO - Return code: 0 01:54:37 INFO - grabbing minidump binary from tooltool 01:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:37 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 0x1bff570>, '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 0x1c00470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:54:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:54:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:54:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:54:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:54:37 INFO - Return code: 0 01:54:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:54:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:54:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:54:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:54:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:54:37 INFO - Using env: {'DISPLAY': ':0', 01:54:37 INFO - 'HOME': '/home/cltbld', 01:54:37 INFO - 'LANG': 'en_US.UTF-8', 01:54:37 INFO - 'LANGUAGE': 'en_US:en', 01:54:37 INFO - 'LOGNAME': 'cltbld', 01:54:37 INFO - 'MAIL': '/var/mail/cltbld', 01:54:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:54:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:37 INFO - 'MOZ_NO_REMOTE': '1', 01:54:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:37 INFO - 'NO_EM_RESTART': '1', 01:54:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:37 INFO - 'PWD': '/builds/slave/test', 01:54:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:54:37 INFO - 'SHELL': '/bin/bash', 01:54:37 INFO - 'SHLVL': '1', 01:54:37 INFO - 'TERM': 'linux', 01:54:37 INFO - 'TMOUT': '86400', 01:54:37 INFO - 'USER': 'cltbld', 01:54:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855', 01:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:37 INFO - '_': '/tools/buildbot/bin/python'} 01:54:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:54:38 INFO - mozversion application_buildid: 20160712005526 01:54:38 INFO - mozversion application_changeset: 0d13d82daefda68120e464c2428a0f1124f2f780 01:54:38 INFO - mozversion application_display_name: Nightly 01:54:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:54:38 INFO - mozversion application_name: Firefox 01:54:38 INFO - mozversion application_remotingname: firefox 01:54:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:54:38 INFO - mozversion application_vendor: Mozilla 01:54:38 INFO - mozversion application_version: 50.0a1 01:54:38 INFO - mozversion platform_buildid: 20160712005526 01:54:38 INFO - mozversion platform_changeset: 0d13d82daefda68120e464c2428a0f1124f2f780 01:54:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:54:38 INFO - mozversion platform_version: 50.0a1 01:54:38 INFO - using testdate: 1468313678 01:54:38 INFO - actual date: 1468313678 01:54:38 INFO - starting webserver on 'localhost:53069' 01:54:38 INFO - SUITE-START | Running 2 tests 01:54:38 INFO - TEST-START | dromaeo_css 01:54:38 INFO - operating with platform_type : linux_ 01:54:38 INFO - Initialising browser for dromaeo_css test... 01:54:38 INFO - TEST-INFO | started process 9805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4Rc5M/profile http://localhost:53069/getInfo.html) 01:54:43 INFO - PROCESS | 9805 | __metrics Screen width/height:1600/1200 01:54:43 INFO - PROCESS | 9805 | colorDepth:24 01:54:43 INFO - PROCESS | 9805 | Browser inner width/height: 1024/697 01:54:43 INFO - PROCESS | 9805 | __metrics 01:54:44 ERROR - PROCESS | 9805 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 01:54:45 INFO - TEST-INFO | 9805: exit 0 01:54:45 INFO - Browser initialized. 01:54:45 INFO - Running cycle 1/1 for dromaeo_css test... 01:54:45 INFO - TEST-INFO | started process 9923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4Rc5M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:57 INFO - PROCESS | 9923 | RSS: Main: 168783872 01:54:57 INFO - PROCESS | 9923 | 01:55:47 INFO - PROCESS | 9923 | 1468313747083 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:58:00 INFO - PROCESS | 9923 | Cycle 1(1): loaded http://localhost:53069/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53069/tests/dromaeo/cssquery-ext.html) 01:58:01 INFO - PROCESS | 9923 | RSS: Main: 169218048 01:58:01 INFO - PROCESS | 9923 | 02:01:03 INFO - PROCESS | 9923 | Cycle 1(1): loaded http://localhost:53069/tests/dromaeo/cssquery-ext.html (next: http://localhost:53069/tests/dromaeo/cssquery-jquery.html) 02:01:04 INFO - PROCESS | 9923 | RSS: Main: 168386560 02:01:04 INFO - PROCESS | 9923 | 02:04:06 INFO - PROCESS | 9923 | Cycle 1(1): loaded http://localhost:53069/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53069/tests/dromaeo/cssquery-mootools.html) 02:04:06 INFO - PROCESS | 9923 | RSS: Main: 171139072 02:04:06 INFO - PROCESS | 9923 | 02:07:08 INFO - PROCESS | 9923 | Cycle 1(1): loaded http://localhost:53069/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53069/tests/dromaeo/cssquery-prototype.html) 02:07:09 INFO - PROCESS | 9923 | RSS: Main: 166830080 02:07:09 INFO - PROCESS | 9923 | 02:10:12 INFO - PROCESS | 9923 | Cycle 1(1): loaded http://localhost:53069/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53069/tests/dromaeo/cssquery-yui.html) 02:10:13 INFO - PROCESS | 9923 | RSS: Main: 168775680 02:10:13 INFO - PROCESS | 9923 | 02:13:15 INFO - PROCESS | 9923 | Cycle 1(1): loaded http://localhost:53069/tests/dromaeo/cssquery-yui.html (next: http://localhost:53069/tests/dromaeo/cssquery-dojo.html) 02:13:16 INFO - PROCESS | 9923 | RSS: Main: 170860544 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | __start_tp_report 02:13:16 INFO - PROCESS | 9923 | _x_x_mozilla_page_load 02:13:16 INFO - PROCESS | 9923 | _x_x_mozilla_page_load_details 02:13:16 INFO - PROCESS | 9923 | |i|pagename|runs| 02:13:16 INFO - PROCESS | 9923 | |0;dojo.html;2637.9604305935413;2646.2855029142133;2661.94676106478;2668.90658826941;2673.1178711025364;4755.215389460739;4821.686590371623;4892.779824907879;4927.063857867003;4962.801487940478;4760.690555113923;4825.420949486067;4850.442199147099;4863.805447782084;4902.901941961168;4477.238869392203;4503.527129651388;4535.841245556389;4603.355530225771;4653.6044436222965;4264.23243816113;4548.590626843584;4559.202139625569;4585.151746926813;4617.607503362218;4367.126574685044;4386.934195987063;4391.297392417198;4501.504834468205;4534.251848445003;4484.932726009112;4499.910001799978;4503.707259028185;4514.6614003949835;4541.545845415432;4525.9547404525865;4541;4554.38515800366;4559.977200114012;4584.381108550337;4892.75536223191;4916.213405855082;4932.654714170009;4954.87612809679;4957.752112394402;5293.497117773805;5314.149736042254;5324.068288049576;5352.732363381854;5358.812441564526;5158.097332966716;5356.946430535684;5358.866028349284;5365.302510673627;5377.085895397791;4861.124997500484;4917.631177661689;4931.0630980113665;4935;4937.876553086202;5394.433584473652;5426.375966763794;5446.210299506629;5446.945530544644;5452.26394436746;5120.513551212629;5159.226116082543;5178.430372659004;5182.274481572583;5213.817516386908;5103.132467480537;5211.661242019332;5250.369955605352;5252.107141785906;5255.290535777697;5224.52979231871;5274.129768588216;5294.602904782157;5299.284596579412;5303.310569625924;5212.46007185817;5237.5548078413;5296.179092240709;5308.681479111266;5352;4420.204363214588;4491.8203271869415;4530.026044400403;4532.9320060199125;4552.795124219418;3911.6870650347905;3925.0776067624083;3942.152437225953;3977.2840888639744;3982.1637456134536;4494.52807455219;4575.359449677047;4578.404807375086;4603.608693261043;4667.673262871566;5243.187305967581;5263.921041184385;5319.787208511616;5335.1730481775385;5353.411124776271;4526.072155208174;4556.430446194226;4583.381243532081;4588.678792484561;4624.745638989888;4643.071385722869;4677.579017888406;4761.833335833298;4787.257975013808;4822.445418776815;4898.853034408973;4922.630802689741;4935.679180853233;4940.827071052496;4983.75081245929;5236.633435659467;5295;5303.416624171261;5304;5352.9464705354;4822.927656085091;4912.508749125059;4940.258961155855;4957.231629097351;4974.427940786856;5247.370315562157;5272.947270527246;5274.446183150714;5279.39286982002;5321.281626980308;5323.760430780547;5327.174287985368;5337.519623233928;5343.9198412024625;5400.62195646301;5000.374953130859;5026.949730502648;5129.948700512947;5192.506711862367;5196.7401629917595;5098.490150984871;5099.209622508517;5109.156989096906;5109.182530795055;5158.871028224325;5059.569936555434;5095.796168153232;5113.795448182031;5115.335006449287;5123.308353372396;5043.218301163325;5111.948880511147;5144.125498665311;5159.071367153948;5211.687298762086;5030.597552195889;5030.798768049237;5036.949630503648;5043.394792624908;5094.465081166572 02:13:16 INFO - PROCESS | 9923 | |1;ext.html;544.5072209650267;546.1807289066403;570.221647451229;584.2988413903314;591.1516973143537;35698.82150589247;40212.39681404781;40268;40283.194336113294;40297.1940561189;40274.19451610973;40976.38535421971;41092.17815643685;41103;41182.588174118326;7838.29455349017;7918.4457088003865;7949.40379471539;7980.561069141195;7985.121636619967;7843.960780196091;7859.8035049123655;7876.842463150733;7877.369810415153;7925.643346049442;7977.680892764282;8015.799605009863;8022.799430014238;8023.037235531715;8024;7930.325922296612;7948.364130869545;7956.085050219241;7976.601169941479;7980.3615710743;8007.1992800720045;8071.919280807234;8078.313343365762;8081.5555144467035;8096.068952070528;38073.238535229415;38585.61414385848;38591.42112868309;38605;38642.80678596617;3246.870125194989;3313.7017668409717;3415.043787739437;3586.246888153491;3790.65884070435;30012.399752004836;30373.69626303731;30391;30438;30562.235944101354;3269.3134441767256;3346.1801858544814;3426.9143271418166;3427.53728246686;3513.0339156731848;270689;272172;275423;275599;275674;55522.16716749252;55543.33479982428;55603.44396556063;55676;55891.72054139703;58303;58386.708066459396;58474;58772.41227587755;58848.70575647095;14699.412023519153;15160.09039457636;15170.924145379202;15186.848131518764;15315.770263446057;11529.711757206136;11553.191276610725;11614.593489227836;11616.361100139573;11635.650930472098;16312.184390780414;16851.241694123793;16948.23732932021;16967.91516042412;17066.48800535961;6343.238811342669;6357.809265722036;6483.189601299838;6501.546440688144;6553.770618028441;805.3275514944969;922.1608336413965;937.1659223291276;940.5955439161089;1032.5301987595626;28523.42953140967;29037.83330169732;29361.265968350963;29569.408611828072;29701;989.7327721515151;995.1988649137369;1028.4806172882795;1034.7413146713322;1036.7252678040325;15169.696606068037;15445.768313475306;15578.205486563093;15595.922020389826;15683.607909802346;371445;372330;372873;375870;376739;50100.498995009584;50181.498185017685;50223.74888125536;50252;50463.49536504588;1150.453534571072;1188.197966372695;1196.6545570681562;1205.5238180918489;1206.0351718625066;26599.601005985314;28913.132606021853;28946.27634309159;29142.41715165727;29220.26949326284;44212.336814948445;44459.777701111285;44799.55200447954;44841.327380088675;44944.17974472207;336105;336191;336289;336717;336858;37106.25787484181;37714.43428348632;38856.725760166926;38927.221455570165;38946.6105338943;43165.352519712855;43701.781491093614;44386.11227775491;44782.10435791331;44906;36330.636693632725;37046.25907481781;37258;37932;37960;36387.45418818773;37416.2516749658;37721.62278377181;37964.810175948944;37977.240455190185;31461.528077078405;37032.814835925645;38327.42508862425;38371.42442863415;39090;31913.202169945936;32995.505067424485;33166.502502462965;33417.66582334146;33850.49224261687;25437.364065898502;25748;25879.611805823304;26010.73989260083;26047.869760651076 02:13:16 INFO - PROCESS | 9923 | |2;jquery.html;356.2412062307285;359.2079464780159;366.8514251728051;383.2603076063197;388.84446221511394;16679.249433775494;17709.291628334868;18471.076446177703;18519.629607407845;18534.907325463355;10493.947530262338;16198.433054843083;17111.82888171121;17119.91440042798;17455.429011388973;4650.953490465095;4761.262004389325;4796.952030479685;4800.927986080212;4811.254255590389;3466.5320181775514;4743.312219728137;5326.520613144816;5607.831765047055;5613.101903695389;5669.149627555879;5680.801171958982;5683;5688.573356998221;5699.544036477072;5579.2746942897365;5600.047991841377;5621.437856214387;5634.802781902655;5648.943510564904;5230.3985041719925;5255.86860328491;5380.569554435636;5394.163904594794;5398.838034858961;12996.675083122904;13137.671558211121;13174.604761857065;13224.404901779442;13282;1876.8967706776123;1910.1786231920269;1948.83434908033;2015.4054553906633;2026.8378529717588;9348.298877584208;9473.431594104375;9521.190698790611;9600.807983840285;9749;1690.138029604898;1710.170567274883;1714.2800023989955;1733.8179491153498;1765.496833402474;70407.64796176038;73109.26890731025;73197.6340118296;74034.25965740328;75323;10206;10277.537510812032;10290.588376465008;10428.270021098602;10464.686059418229;14121.505747298796;14229.28853557318;14271.14373137615;14280.357383917748;14311.499097531536;7109.680064397115;7309;7310.853782924311;7491;7536.284053014955;7004.564064366793;7010.649467526603;7169;7194.460415468756;7197.280271972761;4401.471823381151;4417.1828211780285;4470.776461176928;4554.817807287672;4577.8397756078375;1688.2318545061967;1715.6054107555083;1765.7704498415123;1845.2711179084456;1865.580244444989;820.1101804542019;831.264331066998;832.3050253038781;897;912.7672443526858;15940.282687279101;16746.581335466468;17232.741508877378;17282.567935801704;17343.56641083983;862.8705694145929;868.5961028121827;870.4298684361753;872.2280781508284;931.9207867331218;9407.452657299895;9570.47362395075;9574.760630984281;9592.376495527767;9666.565004574812;382712;384056;385039;385856;389502;76528;79098.20901790909;82607;82846;83693;949.240607513986;968.864358989742;969.9175570076623;972.8151651186251;974.9025097490336;14877.404903803726;14961.177135257665;15267.923660381626;15321.310541025903;15623.531294061197;33845;40018;40333.596664032986;40993;41054.38418423786;55889.44110558843;56355.71822140863;57890;58711.70644146752;59052.704736476044;7339.669714862737;7523.924760752541;7555.206703296295;7665.156832748282;7694.153643099143;10704.732381690521;11024.283421577571;11129.499172537093;11308.83036754433;11418.657440276806;9664.75838104053;9706.126448619658;9905.207583393167;10143.949280253551;10247.128994035591;9431.151196392357;9438.433693978383;9624.711258662252;10049.145822604867;10093.293469457067;9483.383580067273;9650.95174524123;9663.03369663028;9952.900470995197;10131.7467063324;7502.099748030271;7534.773956781305;7588.27911348421;7620.085589729268;7672.194419585863;8208.507489550408;9366.454535001649;9718.319717619981;9751.414915105117;9978.950105249427 02:13:16 INFO - PROCESS | 9923 | |3;mootools.html;1368.9657758556039;1404.0452492305233;1478.2904205981129;1693.5935375509866;1695.4998275508724;6457;7077.893831592523;7199.89200161998;7546.698132074717;7552.35804956578;7267.454940879429;7446.813829654261;7524.134724506684;7538.095428548568;7545.434092443062;2172.2831465616387;2184.552166805801;2184.90167942443;2200.3288996855954;2207.227470385368;2195.5828392605354;2201.218567408563;2228.5320082782637;2230.654248591471;2234.966475502869;2173.913043478259;2189.474526113729;2192.7478339990867;2203.173809821317;2229.1194977983687;2137.3374253981237;2143.431990522513;2145.7961493658077;2146.323907969;2150.731158605174;2127.968080478794;2132;2136.380449669594;2150.666646669769;2152.0638522242716;7441.59071251081;7544.886826697604;7577.507462014952;7584.2794934481135;7586.4689471737;4398.3622374755805;4421.579949904753;4466.642668586505;4473.150101480708;4486.214912390318;2850.586664933594;2862.169970708492;2875.9424811503864;2926.809757365764;2950.439416510856;909.1272378516632;930.3255140023497;932.6595792535743;937.9953100234455;941.6280569175137;10069.949650251776;10118.190544756475;10160.898391016142;10163.949180254125;10172.186225101974;3948.4274780156716;4015.678745700337;4133.111381053088;4158.896027599274;4163.770992595436;8610.655573777103;8658.264047556027;8664.263537599374;8666.739997800076;8683.348748843862;4524.457065152203;4531.003179300548;4567.566081222279;4571.6799824012;4576.450825900846;3578.98210508951;3986.940195897064;4113.91772164555;4203.453551038407;4217.894552636209;3426.8286585670617;3442.8794992175153;3544.3265779502326;3553.8223088845452;3568.750187486851;1157.028096399012;1163.9010684091947;1180.0972256223995;1184.236167671847;1186.3297237061033;743.8884167374937;801.14277722836;811.6834434570522;869.1525762381627;891.1133422244908;4877.975610121926;4970.403551573834;5108.412532558803;5155.304033955368;5179.378474582999;826.3513142183357;853.159637756809;890.3055616619048;900.5272232078212;913.3834661603391;3469.219425629213;3472.2361080562237;3665.9266814663556;3694.833732481991;3731.1045349116016;8530.445521041112;8859.29125669945;8928.196462318423;8939.73180804577;8941.552922353856;8739.650413983369;8746.86879696805;8748.125187481328;8749.47503149813;8862.291016718647;6782.9321706783285;7007.474439417064;7057;7070.045543851617;7092.978501127154;4942.703437793743;5067.721275329893;5110.8466745997675;5257.973710131578;5340.439253878287;8236.629351679068;8324.750257492286;8327.417080804285;8350;8447.493150410995;8219.465734727224;8342.749717508485;8357.832843343222;8379.70671026511;8457.281131103926;5751.1085781703905;6201.410865967726;6316.210473690789;6413.775517856852;6433.420992110732;7200.207977122617;7238.312360325761;7254.5647261164495;7285.344319011315;7331.926680733124;6493.512986525935;6686.197656281277;6700.66496675174;6756.831079222862;6806.65966701653;6495.545311828127;6561.671916404065;6602.537822352389;6636.734530618721;6695.330466953461;6002.069679199731;6079.392060794062;6091.664958427152;6095.634261944298;6098.512119030378;4152.563980781974;4320.956790432181;4329.805158767926;4343.826246950213;4389.868303950887;4612.423447069116;4634.443866736014;4656.953430465787;4695.812167513262;4709.058188362273 02:13:16 INFO - PROCESS | 9923 | |4;prototype.html;291.913885403806;293.404389090147;297.14866906313404;300.3467458278246;300.63322746249565;5154.86073279589;5197.584193264539;5214.687118772877;5224.21636754487;5231.86920326992;5027.09512287788;5110.974445127769;5134.358205224347;5136.075506408845;5147.562457191143;3789.829457674411;3874.8643797467093;3938.5076865391825;3943.7830919299427;3953.5058117735284;3959.8812035638975;3981.701372397067;3985.2826491231567;3993.9201215975663;4003.559608443069;3979.408236705312;3991.6806655467494;4004.2391945530403;4006.2187873364705;4030.435738996543;3729.440583912408;3911.765294082364;3912.765234085964;3999.640032397084;4008.859689910854;3429.108431807723;3445.0870519312402;3449.379111759882;3456.1359660084977;3466.324066806974;4922.75386230687;5003.974980125113;5005;5045.697258164485;5048.217526283432;4287.592678695519;4535.863924082283;4541.591256786905;4552.749598772066;4563.771811409416;5327.573794096463;5335.759890804923;5353.866153346197;5379.300690910196;5399.271098401705;3749.625037496256;3816.637419445148;3818.866339678098;3819.770813751156;3821.923561528754;5358.142697168473;5693.231413759131;5694.174344719992;5715.514181294595;5719.628224165457;3958.1094253793244;3969.64273215412;3998.8000599969887;4021.4973128358956;4049.838006479708;4031.1937612477623;4064.9593504065174;4077.55146933837;4083.530394004668;4093.63157315843;4624.791884365211;4629.842539365159;4634.25851863707;4661.417322834645;4662.7668616569035;5326.493983071602;5339.519443250126;5354.143337066129;5402.6758394496455;5409.134538473825;1399.2723783632455;1411.9364628591738;1414.5473448496382;1421.9502317418842;1422.2959634980543;891.2112780189449;899.9190072893471;909.9818003640023;912.32943786317;947.7820101376722;4576.633869290449;4617.145828021827;4632.97683511587;4641.164590373765;4667.393238878924;5381.3811411687375;5439.564834813205;5441.483059109379;5458.263134476874;5466.562674985991;4518.4126063612175;4636.582707556268;4649.511801260886;4696.600788932979;4700.6944548604915;2873.7557307629086;2896.6234389529227;2912.053582585668;2919.5766613840874;2920.8247505149757;5084.288199652052;5113.670445684149;5130.9230361544605;5146.408163061295;5169.586433085344;5399.973000134974;5611.186377975171;5669.06460434032;5759.314039015034;5773.971130144322;5259.658122222043;5283.735813209324;5289.6146466261625;5299.205119232069;5320.095583750849;5659.575531835047;5660.20757093999;5677.205191273142;5712.857178570569;5714.571407144564;5246.507908743316;5537.7784888604;5537.778488860562;5544.667319960815;5583.609147359808;5254.003478678078;5281.762320695501;5310.389305229948;5311.336082989626;5319.441458646941;3795.089178597172;3866.825992830273;3870.1872606752895;3899.3176194166476;3910.237503686754;5552.52803511706;5580.469855363734;5581.358143813513;5622.971885140548;5630.5214056805635;5451.863703407446;5459.434065988979;5464.672119672832;5487.189227554817;5492.231087647652;5178.766955486937;5414.214938833768;5420.241166236809;5442.156465747816;5493.917591236214;5362.356517217959;5379.515843574097;5386.703731294817;5407.540359069366;5417.377001644862;5217.399999000164;5324;5463;5503.642263252876;5520.66875987442;5371.194320851903;5389.461053894736;5391.487808658171;5394.163904594794;5403.540699040625 02:13:16 INFO - PROCESS | 9923 | |5;yui.html;651.1925212736207;663.2969052804025;674.3020973292643;695.3984803145278;726.7892311229743;11688.649340519776;11754.941225293873;12370.690732731686;12371.814422783655;12415.255084694902;12162.452689628966;12221.938890305537;12264.63206103816;12301.200421972588;12306.56927007555;622.163190508765;755.4598462099598;759.8214419611373;773.6054612147817;778.0507780507771;778.5601135358532;780.5394817057935;781.1563511407694;781.4842204145265;781.8006408365859;818.9877151842697;821.6959724901794;821.7945513621595;823.172711425017;825.8265764189528;808.7290757596212;812.715549557656;813.8657121574932;815.5514467043132;816.3346872299087;597.2146627185281;597.3667912013279;597.8624916269282;599.4125756758401;599.5173885022599;12769.361531923367;12834.16577922432;12949.287789171593;12975.480980760853;12978;13561.45754169832;13575.321233938264;14001;14398.136111833219;14480.782788258184;10747.19396045292;10800.813209699028;10881.347119172795;10947.452627368679;10948.507317170666;3407.4037043517287;3465.2722928184858;3475.3744326021306;3492.965070349315;3529.541159649229;66590.33409665938;67009.66495167541;67237;67614.66192669055;68031.65984170047;10912.181586381053;10939.890601093886;10948.562057517769;11044.392558409365;11178.27341222818;20928;21051.263205787724;21092.578148437253;21125.26061587837;21239.150433982777;6975.686094125776;6995.965020174968;7046.753363632249;7195.640217989185;7212.927870721331;3671.3575124353133;3696.5564132304294;3699.7780133192095;3720.9441858372147;3740.251949610089;2848.9857550712113;2964.9407011859644;2975.895843645462;2991.820490770561;2992.5062364710016;477.5129368044575;494.0982706560541;495.990080198394;496.33738958490096;500.09732432958134;589.5578316262803;598.1476396135489;614.1279383275759;636.6116668832009;653.7058323754329;7730.188330225245;7980.241877021674;8389.454685445426;8583.828323433496;8584.8712269316;476.37204557721896;522.3053339059043;556.1962963517678;597.3269618457455;624.5160000999172;3960.584138665456;4077.89805254871;4080.2451546464;4144.70987030911;4156.189543039139;57179.42820571824;58971.692547670056;100689;104708;104991.47504262583;55556;85335;85752.57123714342;86204.56897715597;86309.56845215734;43802;45356;59553.70223148856;77985.99999999886;78257.60871195607;7694.615269236404;7833.49082309648;7848.332891704269;7924.15678395966;7951.443398962017;44599;46383.76808116073;46449.76775116103;48254;48481.5151848477;63264.68367658132;69239;69472.30527694659;69674.65162674357;69818.65090674514;10635.14918806478;11037.172212083966;11038.558457661924;11090.168237382068;11120.721981950515;11056.170787190831;11292.548298068314;11457;11503.48234329474;11696.473658685209;9882.901170988198;10512.526936288039;11668.358240296866;12184.390780461119;12370.755522038555;12082.69138358973;12376.443060062138;12549.811752823533;12729.55446559366;13374.06381553282;9681.612735490502;11395.544178232778;11817.054635629302;11940.641780746591;12436.502539898303;10100.595976161165;10140.695779126638;10285.74285642865;10520.78958420812;11107.666769996913;9262.72211833646;10584.788304233718;11054.613088541862;11253.943730281297;11278.718032049264 02:13:16 INFO - PROCESS | 9923 | __end_tp_report 02:13:16 INFO - PROCESS | 9923 | __start_cc_report 02:13:16 INFO - PROCESS | 9923 | _x_x_mozilla_cycle_collect,382 02:13:16 INFO - PROCESS | 9923 | __end_cc_report 02:13:16 INFO - PROCESS | 9923 | __startTimestamp1468314796042__endTimestamp 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | ------- Summary: start ------- 02:13:16 INFO - PROCESS | 9923 | Number of tests: 6 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | [#0] dojo.html Cycles:165 Average:4871.52 Median:4962.80 stddev:527.32 (10.6%) stddev-sans-first:498.97 02:13:16 INFO - PROCESS | 9923 | Values: 2638.0 2646.3 2661.9 2668.9 2673.1 4755.2 4821.7 4892.8 4927.1 4962.8 4760.7 4825.4 4850.4 4863.8 4902.9 4477.2 4503.5 4535.8 4603.4 4653.6 4264.2 4548.6 4559.2 4585.2 4617.6 4367.1 4386.9 4391.3 4501.5 4534.3 4484.9 4499.9 4503.7 4514.7 4541.5 4526.0 4541.0 4554.4 4560.0 4584.4 4892.8 4916.2 4932.7 4954.9 4957.8 5293.5 5314.1 5324.1 5352.7 5358.8 5158.1 5356.9 5358.9 5365.3 5377.1 4861.1 4917.6 4931.1 4935.0 4937.9 5394.4 5426.4 5446.2 5446.9 5452.3 5120.5 5159.2 5178.4 5182.3 5213.8 5103.1 5211.7 5250.4 5252.1 5255.3 5224.5 5274.1 5294.6 5299.3 5303.3 5212.5 5237.6 5296.2 5308.7 5352.0 4420.2 4491.8 4530.0 4532.9 4552.8 3911.7 3925.1 3942.2 3977.3 3982.2 4494.5 4575.4 4578.4 4603.6 4667.7 5243.2 5263.9 5319.8 5335.2 5353.4 4526.1 4556.4 4583.4 4588.7 4624.7 4643.1 4677.6 4761.8 4787.3 4822.4 4898.9 4922.6 4935.7 4940.8 4983.8 5236.6 5295.0 5303.4 5304.0 5352.9 4822.9 4912.5 4940.3 4957.2 4974.4 5247.4 5272.9 5274.4 5279.4 5321.3 5323.8 5327.2 5337.5 5343.9 5400.6 5000.4 5026.9 5129.9 5192.5 5196.7 5098.5 5099.2 5109.2 5109.2 5158.9 5059.6 5095.8 5113.8 5115.3 5123.3 5043.2 5111.9 5144.1 5159.1 5211.7 5030.6 5030.8 5036.9 5043.4 5094.5 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | [#1] ext.html Cycles:180 Average:49143.43 Median:37946.00 stddev:86845.77 (228.9%) stddev-sans-first:87012.74 02:13:16 INFO - PROCESS | 9923 | Values: 544.5 546.2 570.2 584.3 591.2 35698.8 40212.4 40268.0 40283.2 40297.2 40274.2 40976.4 41092.2 41103.0 41182.6 7838.3 7918.4 7949.4 7980.6 7985.1 7844.0 7859.8 7876.8 7877.4 7925.6 7977.7 8015.8 8022.8 8023.0 8024.0 7930.3 7948.4 7956.1 7976.6 7980.4 8007.2 8071.9 8078.3 8081.6 8096.1 38073.2 38585.6 38591.4 38605.0 38642.8 3246.9 3313.7 3415.0 3586.2 3790.7 30012.4 30373.7 30391.0 30438.0 30562.2 3269.3 3346.2 3426.9 3427.5 3513.0 270689.0 272172.0 275423.0 275599.0 275674.0 55522.2 55543.3 55603.4 55676.0 55891.7 58303.0 58386.7 58474.0 58772.4 58848.7 14699.4 15160.1 15170.9 15186.8 15315.8 11529.7 11553.2 11614.6 11616.4 11635.7 16312.2 16851.2 16948.2 16967.9 17066.5 6343.2 6357.8 6483.2 6501.5 6553.8 805.3 922.2 937.2 940.6 1032.5 28523.4 29037.8 29361.3 29569.4 29701.0 989.7 995.2 1028.5 1034.7 1036.7 15169.7 15445.8 15578.2 15595.9 15683.6 371445.0 372330.0 372873.0 375870.0 376739.0 50100.5 50181.5 50223.7 50252.0 50463.5 1150.5 1188.2 1196.7 1205.5 1206.0 26599.6 28913.1 28946.3 29142.4 29220.3 44212.3 44459.8 44799.6 44841.3 44944.2 336105.0 336191.0 336289.0 336717.0 336858.0 37106.3 37714.4 38856.7 38927.2 38946.6 43165.4 43701.8 44386.1 44782.1 44906.0 36330.6 37046.3 37258.0 37932.0 37960.0 36387.5 37416.3 37721.6 37964.8 37977.2 31461.5 37032.8 38327.4 38371.4 39090.0 31913.2 32995.5 33166.5 33417.7 33850.5 25437.4 25748.0 25879.6 26010.7 26047.9 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | [#2] jquery.html Cycles:180 Average:24388.31 Median:5387.37 stddev:63990.55 (1187.8%) stddev-sans-first:64144.62 02:13:16 INFO - PROCESS | 9923 | Values: 356.2 359.2 366.9 383.3 388.8 16679.2 17709.3 18471.1 18519.6 18534.9 10493.9 16198.4 17111.8 17119.9 17455.4 4651.0 4761.3 4797.0 4800.9 4811.3 3466.5 4743.3 5326.5 5607.8 5613.1 5669.1 5680.8 5683.0 5688.6 5699.5 5579.3 5600.0 5621.4 5634.8 5648.9 5230.4 5255.9 5380.6 5394.2 5398.8 12996.7 13137.7 13174.6 13224.4 13282.0 1876.9 1910.2 1948.8 2015.4 2026.8 9348.3 9473.4 9521.2 9600.8 9749.0 1690.1 1710.2 1714.3 1733.8 1765.5 70407.6 73109.3 73197.6 74034.3 75323.0 10206.0 10277.5 10290.6 10428.3 10464.7 14121.5 14229.3 14271.1 14280.4 14311.5 7109.7 7309.0 7310.9 7491.0 7536.3 7004.6 7010.6 7169.0 7194.5 7197.3 4401.5 4417.2 4470.8 4554.8 4577.8 1688.2 1715.6 1765.8 1845.3 1865.6 820.1 831.3 832.3 897.0 912.8 15940.3 16746.6 17232.7 17282.6 17343.6 862.9 868.6 870.4 872.2 931.9 9407.5 9570.5 9574.8 9592.4 9666.6 382712.0 384056.0 385039.0 385856.0 389502.0 76528.0 79098.2 82607.0 82846.0 83693.0 949.2 968.9 969.9 972.8 974.9 14877.4 14961.2 15267.9 15321.3 15623.5 33845.0 40018.0 40333.6 40993.0 41054.4 55889.4 56355.7 57890.0 58711.7 59052.7 7339.7 7523.9 7555.2 7665.2 7694.2 10704.7 11024.3 11129.5 11308.8 11418.7 9664.8 9706.1 9905.2 10143.9 10247.1 9431.2 9438.4 9624.7 10049.1 10093.3 9483.4 9651.0 9663.0 9952.9 10131.7 7502.1 7534.8 7588.3 7620.1 7672.2 8208.5 9366.5 9718.3 9751.4 9979.0 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | [#3] mootools.html Cycles:180 Average:4934.08 Median:5133.08 stddev:2668.17 (52.0%) stddev-sans-first:2662.20 02:13:16 INFO - PROCESS | 9923 | Values: 1369.0 1404.0 1478.3 1693.6 1695.5 6457.0 7077.9 7199.9 7546.7 7552.4 7267.5 7446.8 7524.1 7538.1 7545.4 2172.3 2184.6 2184.9 2200.3 2207.2 2195.6 2201.2 2228.5 2230.7 2235.0 2173.9 2189.5 2192.7 2203.2 2229.1 2137.3 2143.4 2145.8 2146.3 2150.7 2128.0 2132.0 2136.4 2150.7 2152.1 7441.6 7544.9 7577.5 7584.3 7586.5 4398.4 4421.6 4466.6 4473.2 4486.2 2850.6 2862.2 2875.9 2926.8 2950.4 909.1 930.3 932.7 938.0 941.6 10069.9 10118.2 10160.9 10163.9 10172.2 3948.4 4015.7 4133.1 4158.9 4163.8 8610.7 8658.3 8664.3 8666.7 8683.3 4524.5 4531.0 4567.6 4571.7 4576.5 3579.0 3986.9 4113.9 4203.5 4217.9 3426.8 3442.9 3544.3 3553.8 3568.8 1157.0 1163.9 1180.1 1184.2 1186.3 743.9 801.1 811.7 869.2 891.1 4878.0 4970.4 5108.4 5155.3 5179.4 826.4 853.2 890.3 900.5 913.4 3469.2 3472.2 3665.9 3694.8 3731.1 8530.4 8859.3 8928.2 8939.7 8941.6 8739.7 8746.9 8748.1 8749.5 8862.3 6782.9 7007.5 7057.0 7070.0 7093.0 4942.7 5067.7 5110.8 5258.0 5340.4 8236.6 8324.8 8327.4 8350.0 8447.5 8219.5 8342.7 8357.8 8379.7 8457.3 5751.1 6201.4 6316.2 6413.8 6433.4 7200.2 7238.3 7254.6 7285.3 7331.9 6493.5 6686.2 6700.7 6756.8 6806.7 6495.5 6561.7 6602.5 6636.7 6695.3 6002.1 6079.4 6091.7 6095.6 6098.5 4152.6 4321.0 4329.8 4343.8 4389.9 4612.4 4634.4 4657.0 4695.8 4709.1 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | [#4] prototype.html Cycles:180 Average:4478.33 Median:5135.22 stddev:1314.67 (25.6%) stddev-sans-first:1280.26 02:13:16 INFO - PROCESS | 9923 | Values: 291.9 293.4 297.1 300.3 300.6 5154.9 5197.6 5214.7 5224.2 5231.9 5027.1 5111.0 5134.4 5136.1 5147.6 3789.8 3874.9 3938.5 3943.8 3953.5 3959.9 3981.7 3985.3 3993.9 4003.6 3979.4 3991.7 4004.2 4006.2 4030.4 3729.4 3911.8 3912.8 3999.6 4008.9 3429.1 3445.1 3449.4 3456.1 3466.3 4922.8 5004.0 5005.0 5045.7 5048.2 4287.6 4535.9 4541.6 4552.7 4563.8 5327.6 5335.8 5353.9 5379.3 5399.3 3749.6 3816.6 3818.9 3819.8 3821.9 5358.1 5693.2 5694.2 5715.5 5719.6 3958.1 3969.6 3998.8 4021.5 4049.8 4031.2 4065.0 4077.6 4083.5 4093.6 4624.8 4629.8 4634.3 4661.4 4662.8 5326.5 5339.5 5354.1 5402.7 5409.1 1399.3 1411.9 1414.5 1422.0 1422.3 891.2 899.9 910.0 912.3 947.8 4576.6 4617.1 4633.0 4641.2 4667.4 5381.4 5439.6 5441.5 5458.3 5466.6 4518.4 4636.6 4649.5 4696.6 4700.7 2873.8 2896.6 2912.1 2919.6 2920.8 5084.3 5113.7 5130.9 5146.4 5169.6 5400.0 5611.2 5669.1 5759.3 5774.0 5259.7 5283.7 5289.6 5299.2 5320.1 5659.6 5660.2 5677.2 5712.9 5714.6 5246.5 5537.8 5537.8 5544.7 5583.6 5254.0 5281.8 5310.4 5311.3 5319.4 3795.1 3866.8 3870.2 3899.3 3910.2 5552.5 5580.5 5581.4 5623.0 5630.5 5451.9 5459.4 5464.7 5487.2 5492.2 5178.8 5414.2 5420.2 5442.2 5493.9 5362.4 5379.5 5386.7 5407.5 5417.4 5217.4 5324.0 5463.0 5503.6 5520.7 5371.2 5389.5 5391.5 5394.2 5403.5 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - PROCESS | 9923 | [#5] yui.html Cycles:180 Average:17366.71 Median:44200.50 stddev:24364.75 (55.1%) stddev-sans-first:24400.77 02:13:16 INFO - PROCESS | 9923 | Values: 651.2 663.3 674.3 695.4 726.8 11688.6 11754.9 12370.7 12371.8 12415.3 12162.5 12221.9 12264.6 12301.2 12306.6 622.2 755.5 759.8 773.6 778.1 778.6 780.5 781.2 781.5 781.8 819.0 821.7 821.8 823.2 825.8 808.7 812.7 813.9 815.6 816.3 597.2 597.4 597.9 599.4 599.5 12769.4 12834.2 12949.3 12975.5 12978.0 13561.5 13575.3 14001.0 14398.1 14480.8 10747.2 10800.8 10881.3 10947.5 10948.5 3407.4 3465.3 3475.4 3493.0 3529.5 66590.3 67009.7 67237.0 67614.7 68031.7 10912.2 10939.9 10948.6 11044.4 11178.3 20928.0 21051.3 21092.6 21125.3 21239.2 6975.7 6996.0 7046.8 7195.6 7212.9 3671.4 3696.6 3699.8 3720.9 3740.3 2849.0 2964.9 2975.9 2991.8 2992.5 477.5 494.1 496.0 496.3 500.1 589.6 598.1 614.1 636.6 653.7 7730.2 7980.2 8389.5 8583.8 8584.9 476.4 522.3 556.2 597.3 624.5 3960.6 4077.9 4080.2 4144.7 4156.2 57179.4 58971.7 100689.0 104708.0 104991.5 55556.0 85335.0 85752.6 86204.6 86309.6 43802.0 45356.0 59553.7 77986.0 78257.6 7694.6 7833.5 7848.3 7924.2 7951.4 44599.0 46383.8 46449.8 48254.0 48481.5 63264.7 69239.0 69472.3 69674.7 69818.7 10635.1 11037.2 11038.6 11090.2 11120.7 11056.2 11292.5 11457.0 11503.5 11696.5 9882.9 10512.5 11668.4 12184.4 12370.8 12082.7 12376.4 12549.8 12729.6 13374.1 9681.6 11395.5 11817.1 11940.6 12436.5 10100.6 10140.7 10285.7 10520.8 11107.7 9262.7 10584.8 11054.6 11253.9 11278.7 02:13:16 INFO - PROCESS | 9923 | -------- Summary: end -------- 02:13:16 INFO - PROCESS | 9923 | 02:13:16 INFO - TEST-INFO | 9923: exit 0 02:13:16 INFO - TEST-OK | dromaeo_css | took 1118765ms 02:13:16 INFO - TEST-START | kraken 02:13:16 INFO - operating with platform_type : linux_ 02:13:16 INFO - Initialising browser for kraken test... 02:13:16 INFO - TEST-INFO | started process 10167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6MIjsM/profile http://localhost:53069/getInfo.html) 02:13:22 INFO - PROCESS | 10167 | __metrics Screen width/height:1600/1200 02:13:22 INFO - PROCESS | 10167 | colorDepth:24 02:13:22 INFO - PROCESS | 10167 | Browser inner width/height: 1024/697 02:13:22 INFO - PROCESS | 10167 | __metrics 02:13:22 ERROR - PROCESS | 10167 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 02:13:23 INFO - TEST-INFO | 10167: exit 0 02:13:23 INFO - Browser initialized. 02:13:23 INFO - Running cycle 1/1 for kraken test... 02:13:23 INFO - TEST-INFO | started process 10285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6MIjsM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:35 INFO - PROCESS | 10285 | RSS: Main: 168607744 02:13:35 INFO - PROCESS | 10285 | 02:13:38 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53069/tests/kraken/driver.html?testName=audio-beat-detection) 02:13:39 INFO - PROCESS | 10285 | RSS: Main: 173133824 02:13:39 INFO - PROCESS | 10285 | 02:13:42 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53069/tests/kraken/driver.html?testName=audio-dft) 02:13:42 INFO - PROCESS | 10285 | RSS: Main: 173355008 02:13:42 INFO - PROCESS | 10285 | 02:13:45 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53069/tests/kraken/driver.html?testName=audio-fft) 02:13:46 INFO - PROCESS | 10285 | RSS: Main: 168189952 02:13:46 INFO - PROCESS | 10285 | 02:13:48 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53069/tests/kraken/driver.html?testName=audio-oscillator) 02:13:49 INFO - PROCESS | 10285 | RSS: Main: 168919040 02:13:49 INFO - PROCESS | 10285 | 02:13:51 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53069/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:13:52 INFO - PROCESS | 10285 | RSS: Main: 169287680 02:13:52 INFO - PROCESS | 10285 | 02:13:55 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53069/tests/kraken/driver.html?testName=imaging-darkroom) 02:13:55 INFO - PROCESS | 10285 | RSS: Main: 169447424 02:13:55 INFO - PROCESS | 10285 | 02:13:59 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53069/tests/kraken/driver.html?testName=imaging-desaturate) 02:14:00 INFO - PROCESS | 10285 | RSS: Main: 167755776 02:14:00 INFO - PROCESS | 10285 | 02:14:03 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53069/tests/kraken/driver.html?testName=json-parse-financial) 02:14:03 INFO - PROCESS | 10285 | RSS: Main: 168710144 02:14:03 INFO - PROCESS | 10285 | 02:14:05 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53069/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:14:06 INFO - PROCESS | 10285 | RSS: Main: 169381888 02:14:06 INFO - PROCESS | 10285 | 02:14:07 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:14:08 INFO - PROCESS | 10285 | RSS: Main: 169082880 02:14:08 INFO - PROCESS | 10285 | 02:14:10 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:14:11 INFO - PROCESS | 10285 | RSS: Main: 169594880 02:14:11 INFO - PROCESS | 10285 | 02:14:14 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:14:14 INFO - PROCESS | 10285 | RSS: Main: 170164224 02:14:14 INFO - PROCESS | 10285 | 02:14:17 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:14:18 INFO - PROCESS | 10285 | RSS: Main: 169365504 02:14:18 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:53069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53069/tests/kraken/driver.html?testName=ai-astar) 02:14:20 INFO - PROCESS | 10285 | RSS: Main: 170471424 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | __start_tp_report 02:14:20 INFO - PROCESS | 10285 | _x_x_mozilla_page_load 02:14:20 INFO - PROCESS | 10285 | _x_x_mozilla_page_load_details 02:14:20 INFO - PROCESS | 10285 | |i|pagename|runs| 02:14:20 INFO - PROCESS | 10285 | |0;ai-astar;107;116;110;115;114;116;117;115;117;115 02:14:20 INFO - PROCESS | 10285 | |1;audio-beat-detection;159;126;153;182;125;145;159;124;178;127 02:14:20 INFO - PROCESS | 10285 | |2;audio-dft;163;165;166;177;162;163;163;164;163;163 02:14:20 INFO - PROCESS | 10285 | |3;audio-fft;76;80;78;124;80;77;75;77;167;78 02:14:20 INFO - PROCESS | 10285 | |4;audio-oscillator;85;86;138;86;86;85;137;86;88;133 02:14:20 INFO - PROCESS | 10285 | |5;imaging-gaussian-blur;119;118;118;117;118;117;119;117;119;119 02:14:20 INFO - PROCESS | 10285 | |6;imaging-darkroom;149;148;148;147;149;147;148;148;148;148 02:14:20 INFO - PROCESS | 10285 | |7;imaging-desaturate;96;95;96;95;96;96;96;96;96;97 02:14:20 INFO - PROCESS | 10285 | |8;json-parse-financial;63;67;63;63;66;62;63;64;64;66 02:14:20 INFO - PROCESS | 10285 | |9;json-stringify-tinderbox;66;65;68;65;65;66;66;66;65;66 02:14:20 INFO - PROCESS | 10285 | |10;stanford-crypto-aes;86;80;81;81;80;85;80;83;90;83 02:14:20 INFO - PROCESS | 10285 | |11;stanford-crypto-ccm;137;132;130;147;142;132;142;135;184;134 02:14:20 INFO - PROCESS | 10285 | |12;stanford-crypto-pbkdf2;169;172;170;168;174;173;175;179;172;170 02:14:20 INFO - PROCESS | 10285 | |13;stanford-crypto-sha256-iterative;70;69;68;72;73;68;70;68;68;66 02:14:20 INFO - PROCESS | 10285 | __end_tp_report 02:14:20 INFO - PROCESS | 10285 | __start_cc_report 02:14:20 INFO - PROCESS | 10285 | _x_x_mozilla_cycle_collect,999 02:14:20 INFO - PROCESS | 10285 | __end_cc_report 02:14:20 INFO - PROCESS | 10285 | __startTimestamp1468314860544__endTimestamp 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | ------- Summary: start ------- 02:14:20 INFO - PROCESS | 10285 | Number of tests: 14 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:3.22 (2.8%) stddev-sans-first:2.12 02:14:20 INFO - PROCESS | 10285 | Values: 107.0 116.0 110.0 115.0 114.0 116.0 117.0 115.0 117.0 115.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:156.00 stddev:22.01 (14.1%) stddev-sans-first:22.97 02:14:20 INFO - PROCESS | 10285 | Values: 159.0 126.0 153.0 182.0 125.0 145.0 159.0 124.0 178.0 127.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#2] audio-dft Cycles:10 Average:164.90 Median:163.50 stddev:4.41 (2.7%) stddev-sans-first:4.62 02:14:20 INFO - PROCESS | 10285 | Values: 163.0 165.0 166.0 177.0 162.0 163.0 163.0 164.0 163.0 163.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#3] audio-fft Cycles:10 Average:91.20 Median:77.50 stddev:30.40 (39.2%) stddev-sans-first:31.74 02:14:20 INFO - PROCESS | 10285 | Values: 76.0 80.0 78.0 124.0 80.0 77.0 75.0 77.0 167.0 78.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:86.00 stddev:24.20 (28.1%) stddev-sans-first:24.96 02:14:20 INFO - PROCESS | 10285 | Values: 85.0 86.0 138.0 86.0 86.0 85.0 137.0 86.0 88.0 133.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.88 (0.7%) stddev-sans-first:0.87 02:14:20 INFO - PROCESS | 10285 | Values: 119.0 118.0 118.0 117.0 118.0 117.0 119.0 117.0 119.0 119.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 02:14:20 INFO - PROCESS | 10285 | Values: 149.0 148.0 148.0 147.0 149.0 147.0 148.0 148.0 148.0 148.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:14:20 INFO - PROCESS | 10285 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.66 (2.6%) stddev-sans-first:1.72 02:14:20 INFO - PROCESS | 10285 | Values: 63.0 67.0 63.0 63.0 66.0 62.0 63.0 64.0 64.0 66.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 02:14:20 INFO - PROCESS | 10285 | Values: 66.0 65.0 68.0 65.0 65.0 66.0 66.0 66.0 65.0 66.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:3.28 (4.0%) stddev-sans-first:3.28 02:14:20 INFO - PROCESS | 10285 | Values: 86.0 80.0 81.0 81.0 80.0 85.0 80.0 83.0 90.0 83.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:139.50 stddev:15.88 (11.4%) stddev-sans-first:16.76 02:14:20 INFO - PROCESS | 10285 | Values: 137.0 132.0 130.0 147.0 142.0 132.0 142.0 135.0 184.0 134.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.50 stddev:3.26 (1.9%) stddev-sans-first:3.24 02:14:20 INFO - PROCESS | 10285 | Values: 169.0 172.0 170.0 168.0 174.0 173.0 175.0 179.0 172.0 170.0 02:14:20 INFO - PROCESS | 10285 | 02:14:20 INFO - PROCESS | 10285 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:2.10 (3.0%) stddev-sans-first:2.20 02:14:20 INFO - PROCESS | 10285 | Values: 70.0 69.0 68.0 72.0 73.0 68.0 70.0 68.0 68.0 66.0 02:14:20 INFO - PROCESS | 10285 | -------- Summary: end -------- 02:14:20 INFO - PROCESS | 10285 | 02:14:21 INFO - TEST-INFO | 10285: exit 0 02:14:21 INFO - TEST-OK | kraken | took 64990ms 02:14:21 INFO - SUITE-END | took 1183s 02:14:22 INFO - Completed test suite (00:19:44) 02:14:22 INFO - javascript benchmark 02:14:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6516.44237436466, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.9604305935413, 2646.2855029142133, 2661.94676106478, 2668.90658826941, 2673.1178711025364, 4755.215389460739, 4821.686590371623, 4892.779824907879, 4927.063857867003, 4962.801487940478, 4760.690555113923, 4825.420949486067, 4850.442199147099, 4863.805447782084, 4902.901941961168, 4477.238869392203, 4503.527129651388, 4535.841245556389, 4603.355530225771, 4653.6044436222965, 4264.23243816113, 4548.590626843584, 4559.202139625569, 4585.151746926813, 4617.607503362218, 4367.126574685044, 4386.934195987063, 4391.297392417198, 4501.504834468205, 4534.251848445003, 4484.932726009112, 4499.910001799978, 4503.707259028185, 4514.6614003949835, 4541.545845415432, 4525.9547404525865, 4541.0, 4554.38515800366, 4559.977200114012, 4584.381108550337, 4892.75536223191, 4916.213405855082, 4932.654714170009, 4954.87612809679, 4957.752112394402, 5293.497117773805, 5314.149736042254, 5324.068288049576, 5352.732363381854, 5358.812441564526, 5158.097332966716, 5356.946430535684, 5358.866028349284, 5365.302510673627, 5377.085895397791, 4861.124997500484, 4917.631177661689, 4931.0630980113665, 4935.0, 4937.876553086202, 5394.433584473652, 5426.375966763794, 5446.210299506629, 5446.945530544644, 5452.26394436746, 5120.513551212629, 5159.226116082543, 5178.430372659004, 5182.274481572583, 5213.817516386908, 5103.132467480537, 5211.661242019332, 5250.369955605352, 5252.107141785906, 5255.290535777697, 5224.52979231871, 5274.129768588216, 5294.602904782157, 5299.284596579412, 5303.310569625924, 5212.46007185817, 5237.5548078413, 5296.179092240709, 5308.681479111266, 5352.0, 4420.204363214588, 4491.8203271869415, 4530.026044400403, 4532.9320060199125, 4552.795124219418, 3911.6870650347905, 3925.0776067624083, 3942.152437225953, 3977.2840888639744, 3982.1637456134536, 4494.52807455219, 4575.359449677047, 4578.404807375086, 4603.608693261043, 4667.673262871566, 5243.187305967581, 5263.921041184385, 5319.787208511616, 5335.1730481775385, 5353.411124776271, 4526.072155208174, 4556.430446194226, 4583.381243532081, 4588.678792484561, 4624.745638989888, 4643.071385722869, 4677.579017888406, 4761.833335833298, 4787.257975013808, 4822.445418776815, 4898.853034408973, 4922.630802689741, 4935.679180853233, 4940.827071052496, 4983.75081245929, 5236.633435659467, 5295.0, 5303.416624171261, 5304.0, 5352.9464705354, 4822.927656085091, 4912.508749125059, 4940.258961155855, 4957.231629097351, 4974.427940786856, 5247.370315562157, 5272.947270527246, 5274.446183150714, 5279.39286982002, 5321.281626980308, 5323.760430780547, 5327.174287985368, 5337.519623233928, 5343.9198412024625, 5400.62195646301, 5000.374953130859, 5026.949730502648, 5129.948700512947, 5192.506711862367, 5196.7401629917595, 5098.490150984871, 5099.209622508517, 5109.156989096906, 5109.182530795055, 5158.871028224325, 5059.569936555434, 5095.796168153232, 5113.795448182031, 5115.335006449287, 5123.308353372396, 5043.218301163325, 5111.948880511147, 5144.125498665311, 5159.071367153948, 5211.687298762086, 5030.597552195889, 5030.798768049237, 5036.949630503648, 5043.394792624908, 5094.465081166572], "value": 4836.264701012957, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.5072209650267, 546.1807289066403, 570.221647451229, 584.2988413903314, 591.1516973143537, 35698.82150589247, 40212.39681404781, 40268.0, 40283.194336113294, 40297.1940561189, 40274.19451610973, 40976.38535421971, 41092.17815643685, 41103.0, 41182.588174118326, 7838.29455349017, 7918.4457088003865, 7949.40379471539, 7980.561069141195, 7985.121636619967, 7843.960780196091, 7859.8035049123655, 7876.842463150733, 7877.369810415153, 7925.643346049442, 7977.680892764282, 8015.799605009863, 8022.799430014238, 8023.037235531715, 8024.0, 7930.325922296612, 7948.364130869545, 7956.085050219241, 7976.601169941479, 7980.3615710743, 8007.1992800720045, 8071.919280807234, 8078.313343365762, 8081.5555144467035, 8096.068952070528, 38073.238535229415, 38585.61414385848, 38591.42112868309, 38605.0, 38642.80678596617, 3246.870125194989, 3313.7017668409717, 3415.043787739437, 3586.246888153491, 3790.65884070435, 30012.399752004836, 30373.69626303731, 30391.0, 30438.0, 30562.235944101354, 3269.3134441767256, 3346.1801858544814, 3426.9143271418166, 3427.53728246686, 3513.0339156731848, 270689.0, 272172.0, 275423.0, 275599.0, 275674.0, 55522.16716749252, 55543.33479982428, 55603.44396556063, 55676.0, 55891.72054139703, 58303.0, 58386.708066459396, 58474.0, 58772.41227587755, 58848.70575647095, 14699.412023519153, 15160.09039457636, 15170.924145379202, 15186.848131518764, 15315.770263446057, 11529.711757206136, 11553.191276610725, 11614.593489227836, 11616.361100139573, 11635.650930472098, 16312.184390780414, 16851.241694123793, 16948.23732932021, 16967.91516042412, 17066.48800535961, 6343.238811342669, 6357.809265722036, 6483.189601299838, 6501.546440688144, 6553.770618028441, 805.3275514944969, 922.1608336413965, 937.1659223291276, 940.5955439161089, 1032.5301987595626, 28523.42953140967, 29037.83330169732, 29361.265968350963, 29569.408611828072, 29701.0, 989.7327721515151, 995.1988649137369, 1028.4806172882795, 1034.7413146713322, 1036.7252678040325, 15169.696606068037, 15445.768313475306, 15578.205486563093, 15595.922020389826, 15683.607909802346, 371445.0, 372330.0, 372873.0, 375870.0, 376739.0, 50100.498995009584, 50181.498185017685, 50223.74888125536, 50252.0, 50463.49536504588, 1150.453534571072, 1188.197966372695, 1196.6545570681562, 1205.5238180918489, 1206.0351718625066, 26599.601005985314, 28913.132606021853, 28946.27634309159, 29142.41715165727, 29220.26949326284, 44212.336814948445, 44459.777701111285, 44799.55200447954, 44841.327380088675, 44944.17974472207, 336105.0, 336191.0, 336289.0, 336717.0, 336858.0, 37106.25787484181, 37714.43428348632, 38856.725760166926, 38927.221455570165, 38946.6105338943, 43165.352519712855, 43701.781491093614, 44386.11227775491, 44782.10435791331, 44906.0, 36330.636693632725, 37046.25907481781, 37258.0, 37932.0, 37960.0, 36387.45418818773, 37416.2516749658, 37721.62278377181, 37964.810175948944, 37977.240455190185, 31461.528077078405, 37032.814835925645, 38327.42508862425, 38371.42442863415, 39090.0, 31913.202169945936, 32995.505067424485, 33166.502502462965, 33417.66582334146, 33850.49224261687, 25437.364065898502, 25748.0, 25879.611805823304, 26010.73989260083, 26047.869760651076], "value": 18154.296583830263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2412062307285, 359.2079464780159, 366.8514251728051, 383.2603076063197, 388.84446221511394, 16679.249433775494, 17709.291628334868, 18471.076446177703, 18519.629607407845, 18534.907325463355, 10493.947530262338, 16198.433054843083, 17111.82888171121, 17119.91440042798, 17455.429011388973, 4650.953490465095, 4761.262004389325, 4796.952030479685, 4800.927986080212, 4811.254255590389, 3466.5320181775514, 4743.312219728137, 5326.520613144816, 5607.831765047055, 5613.101903695389, 5669.149627555879, 5680.801171958982, 5683.0, 5688.573356998221, 5699.544036477072, 5579.2746942897365, 5600.047991841377, 5621.437856214387, 5634.802781902655, 5648.943510564904, 5230.3985041719925, 5255.86860328491, 5380.569554435636, 5394.163904594794, 5398.838034858961, 12996.675083122904, 13137.671558211121, 13174.604761857065, 13224.404901779442, 13282.0, 1876.8967706776123, 1910.1786231920269, 1948.83434908033, 2015.4054553906633, 2026.8378529717588, 9348.298877584208, 9473.431594104375, 9521.190698790611, 9600.807983840285, 9749.0, 1690.138029604898, 1710.170567274883, 1714.2800023989955, 1733.8179491153498, 1765.496833402474, 70407.64796176038, 73109.26890731025, 73197.6340118296, 74034.25965740328, 75323.0, 10206.0, 10277.537510812032, 10290.588376465008, 10428.270021098602, 10464.686059418229, 14121.505747298796, 14229.28853557318, 14271.14373137615, 14280.357383917748, 14311.499097531536, 7109.680064397115, 7309.0, 7310.853782924311, 7491.0, 7536.284053014955, 7004.564064366793, 7010.649467526603, 7169.0, 7194.460415468756, 7197.280271972761, 4401.471823381151, 4417.1828211780285, 4470.776461176928, 4554.817807287672, 4577.8397756078375, 1688.2318545061967, 1715.6054107555083, 1765.7704498415123, 1845.2711179084456, 1865.580244444989, 820.1101804542019, 831.264331066998, 832.3050253038781, 897.0, 912.7672443526858, 15940.282687279101, 16746.581335466468, 17232.741508877378, 17282.567935801704, 17343.56641083983, 862.8705694145929, 868.5961028121827, 870.4298684361753, 872.2280781508284, 931.9207867331218, 9407.452657299895, 9570.47362395075, 9574.760630984281, 9592.376495527767, 9666.565004574812, 382712.0, 384056.0, 385039.0, 385856.0, 389502.0, 76528.0, 79098.20901790909, 82607.0, 82846.0, 83693.0, 949.240607513986, 968.864358989742, 969.9175570076623, 972.8151651186251, 974.9025097490336, 14877.404903803726, 14961.177135257665, 15267.923660381626, 15321.310541025903, 15623.531294061197, 33845.0, 40018.0, 40333.596664032986, 40993.0, 41054.38418423786, 55889.44110558843, 56355.71822140863, 57890.0, 58711.70644146752, 59052.704736476044, 7339.669714862737, 7523.924760752541, 7555.206703296295, 7665.156832748282, 7694.153643099143, 10704.732381690521, 11024.283421577571, 11129.499172537093, 11308.83036754433, 11418.657440276806, 9664.75838104053, 9706.126448619658, 9905.207583393167, 10143.949280253551, 10247.128994035591, 9431.151196392357, 9438.433693978383, 9624.711258662252, 10049.145822604867, 10093.293469457067, 9483.383580067273, 9650.95174524123, 9663.03369663028, 9952.900470995197, 10131.7467063324, 7502.099748030271, 7534.773956781305, 7588.27911348421, 7620.085589729268, 7672.194419585863, 8208.507489550408, 9366.454535001649, 9718.319717619981, 9751.414915105117, 9978.950105249427], "value": 8128.620206671902, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.9657758556039, 1404.0452492305233, 1478.2904205981129, 1693.5935375509866, 1695.4998275508724, 6457.0, 7077.893831592523, 7199.89200161998, 7546.698132074717, 7552.35804956578, 7267.454940879429, 7446.813829654261, 7524.134724506684, 7538.095428548568, 7545.434092443062, 2172.2831465616387, 2184.552166805801, 2184.90167942443, 2200.3288996855954, 2207.227470385368, 2195.5828392605354, 2201.218567408563, 2228.5320082782637, 2230.654248591471, 2234.966475502869, 2173.913043478259, 2189.474526113729, 2192.7478339990867, 2203.173809821317, 2229.1194977983687, 2137.3374253981237, 2143.431990522513, 2145.7961493658077, 2146.323907969, 2150.731158605174, 2127.968080478794, 2132.0, 2136.380449669594, 2150.666646669769, 2152.0638522242716, 7441.59071251081, 7544.886826697604, 7577.507462014952, 7584.2794934481135, 7586.4689471737, 4398.3622374755805, 4421.579949904753, 4466.642668586505, 4473.150101480708, 4486.214912390318, 2850.586664933594, 2862.169970708492, 2875.9424811503864, 2926.809757365764, 2950.439416510856, 909.1272378516632, 930.3255140023497, 932.6595792535743, 937.9953100234455, 941.6280569175137, 10069.949650251776, 10118.190544756475, 10160.898391016142, 10163.949180254125, 10172.186225101974, 3948.4274780156716, 4015.678745700337, 4133.111381053088, 4158.896027599274, 4163.770992595436, 8610.655573777103, 8658.264047556027, 8664.263537599374, 8666.739997800076, 8683.348748843862, 4524.457065152203, 4531.003179300548, 4567.566081222279, 4571.6799824012, 4576.450825900846, 3578.98210508951, 3986.940195897064, 4113.91772164555, 4203.453551038407, 4217.894552636209, 3426.8286585670617, 3442.8794992175153, 3544.3265779502326, 3553.8223088845452, 3568.750187486851, 1157.028096399012, 1163.9010684091947, 1180.0972256223995, 1184.236167671847, 1186.3297237061033, 743.8884167374937, 801.14277722836, 811.6834434570522, 869.1525762381627, 891.1133422244908, 4877.975610121926, 4970.403551573834, 5108.412532558803, 5155.304033955368, 5179.378474582999, 826.3513142183357, 853.159637756809, 890.3055616619048, 900.5272232078212, 913.3834661603391, 3469.219425629213, 3472.2361080562237, 3665.9266814663556, 3694.833732481991, 3731.1045349116016, 8530.445521041112, 8859.29125669945, 8928.196462318423, 8939.73180804577, 8941.552922353856, 8739.650413983369, 8746.86879696805, 8748.125187481328, 8749.47503149813, 8862.291016718647, 6782.9321706783285, 7007.474439417064, 7057.0, 7070.045543851617, 7092.978501127154, 4942.703437793743, 5067.721275329893, 5110.8466745997675, 5257.973710131578, 5340.439253878287, 8236.629351679068, 8324.750257492286, 8327.417080804285, 8350.0, 8447.493150410995, 8219.465734727224, 8342.749717508485, 8357.832843343222, 8379.70671026511, 8457.281131103926, 5751.1085781703905, 6201.410865967726, 6316.210473690789, 6413.775517856852, 6433.420992110732, 7200.207977122617, 7238.312360325761, 7254.5647261164495, 7285.344319011315, 7331.926680733124, 6493.512986525935, 6686.197656281277, 6700.66496675174, 6756.831079222862, 6806.65966701653, 6495.545311828127, 6561.671916404065, 6602.537822352389, 6636.734530618721, 6695.330466953461, 6002.069679199731, 6079.392060794062, 6091.664958427152, 6095.634261944298, 6098.512119030378, 4152.563980781974, 4320.956790432181, 4329.805158767926, 4343.826246950213, 4389.868303950887, 4612.423447069116, 4634.443866736014, 4656.953430465787, 4695.812167513262, 4709.058188362273], "value": 4028.7396698410216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.913885403806, 293.404389090147, 297.14866906313404, 300.3467458278246, 300.63322746249565, 5154.86073279589, 5197.584193264539, 5214.687118772877, 5224.21636754487, 5231.86920326992, 5027.09512287788, 5110.974445127769, 5134.358205224347, 5136.075506408845, 5147.562457191143, 3789.829457674411, 3874.8643797467093, 3938.5076865391825, 3943.7830919299427, 3953.5058117735284, 3959.8812035638975, 3981.701372397067, 3985.2826491231567, 3993.9201215975663, 4003.559608443069, 3979.408236705312, 3991.6806655467494, 4004.2391945530403, 4006.2187873364705, 4030.435738996543, 3729.440583912408, 3911.765294082364, 3912.765234085964, 3999.640032397084, 4008.859689910854, 3429.108431807723, 3445.0870519312402, 3449.379111759882, 3456.1359660084977, 3466.324066806974, 4922.75386230687, 5003.974980125113, 5005.0, 5045.697258164485, 5048.217526283432, 4287.592678695519, 4535.863924082283, 4541.591256786905, 4552.749598772066, 4563.771811409416, 5327.573794096463, 5335.759890804923, 5353.866153346197, 5379.300690910196, 5399.271098401705, 3749.625037496256, 3816.637419445148, 3818.866339678098, 3819.770813751156, 3821.923561528754, 5358.142697168473, 5693.231413759131, 5694.174344719992, 5715.514181294595, 5719.628224165457, 3958.1094253793244, 3969.64273215412, 3998.8000599969887, 4021.4973128358956, 4049.838006479708, 4031.1937612477623, 4064.9593504065174, 4077.55146933837, 4083.530394004668, 4093.63157315843, 4624.791884365211, 4629.842539365159, 4634.25851863707, 4661.417322834645, 4662.7668616569035, 5326.493983071602, 5339.519443250126, 5354.143337066129, 5402.6758394496455, 5409.134538473825, 1399.2723783632455, 1411.9364628591738, 1414.5473448496382, 1421.9502317418842, 1422.2959634980543, 891.2112780189449, 899.9190072893471, 909.9818003640023, 912.32943786317, 947.7820101376722, 4576.633869290449, 4617.145828021827, 4632.97683511587, 4641.164590373765, 4667.393238878924, 5381.3811411687375, 5439.564834813205, 5441.483059109379, 5458.263134476874, 5466.562674985991, 4518.4126063612175, 4636.582707556268, 4649.511801260886, 4696.600788932979, 4700.6944548604915, 2873.7557307629086, 2896.6234389529227, 2912.053582585668, 2919.5766613840874, 2920.8247505149757, 5084.288199652052, 5113.670445684149, 5130.9230361544605, 5146.408163061295, 5169.586433085344, 5399.973000134974, 5611.186377975171, 5669.06460434032, 5759.314039015034, 5773.971130144322, 5259.658122222043, 5283.735813209324, 5289.6146466261625, 5299.205119232069, 5320.095583750849, 5659.575531835047, 5660.20757093999, 5677.205191273142, 5712.857178570569, 5714.571407144564, 5246.507908743316, 5537.7784888604, 5537.778488860562, 5544.667319960815, 5583.609147359808, 5254.003478678078, 5281.762320695501, 5310.389305229948, 5311.336082989626, 5319.441458646941, 3795.089178597172, 3866.825992830273, 3870.1872606752895, 3899.3176194166476, 3910.237503686754, 5552.52803511706, 5580.469855363734, 5581.358143813513, 5622.971885140548, 5630.5214056805635, 5451.863703407446, 5459.434065988979, 5464.672119672832, 5487.189227554817, 5492.231087647652, 5178.766955486937, 5414.214938833768, 5420.241166236809, 5442.156465747816, 5493.917591236214, 5362.356517217959, 5379.515843574097, 5386.703731294817, 5407.540359069366, 5417.377001644862, 5217.399999000164, 5324.0, 5463.0, 5503.642263252876, 5520.66875987442, 5371.194320851903, 5389.461053894736, 5391.487808658171, 5394.163904594794, 5403.540699040625], "value": 4055.2224505352883, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.1925212736207, 663.2969052804025, 674.3020973292643, 695.3984803145278, 726.7892311229743, 11688.649340519776, 11754.941225293873, 12370.690732731686, 12371.814422783655, 12415.255084694902, 12162.452689628966, 12221.938890305537, 12264.63206103816, 12301.200421972588, 12306.56927007555, 622.163190508765, 755.4598462099598, 759.8214419611373, 773.6054612147817, 778.0507780507771, 778.5601135358532, 780.5394817057935, 781.1563511407694, 781.4842204145265, 781.8006408365859, 818.9877151842697, 821.6959724901794, 821.7945513621595, 823.172711425017, 825.8265764189528, 808.7290757596212, 812.715549557656, 813.8657121574932, 815.5514467043132, 816.3346872299087, 597.2146627185281, 597.3667912013279, 597.8624916269282, 599.4125756758401, 599.5173885022599, 12769.361531923367, 12834.16577922432, 12949.287789171593, 12975.480980760853, 12978.0, 13561.45754169832, 13575.321233938264, 14001.0, 14398.136111833219, 14480.782788258184, 10747.19396045292, 10800.813209699028, 10881.347119172795, 10947.452627368679, 10948.507317170666, 3407.4037043517287, 3465.2722928184858, 3475.3744326021306, 3492.965070349315, 3529.541159649229, 66590.33409665938, 67009.66495167541, 67237.0, 67614.66192669055, 68031.65984170047, 10912.181586381053, 10939.890601093886, 10948.562057517769, 11044.392558409365, 11178.27341222818, 20928.0, 21051.263205787724, 21092.578148437253, 21125.26061587837, 21239.150433982777, 6975.686094125776, 6995.965020174968, 7046.753363632249, 7195.640217989185, 7212.927870721331, 3671.3575124353133, 3696.5564132304294, 3699.7780133192095, 3720.9441858372147, 3740.251949610089, 2848.9857550712113, 2964.9407011859644, 2975.895843645462, 2991.820490770561, 2992.5062364710016, 477.5129368044575, 494.0982706560541, 495.990080198394, 496.33738958490096, 500.09732432958134, 589.5578316262803, 598.1476396135489, 614.1279383275759, 636.6116668832009, 653.7058323754329, 7730.188330225245, 7980.241877021674, 8389.454685445426, 8583.828323433496, 8584.8712269316, 476.37204557721896, 522.3053339059043, 556.1962963517678, 597.3269618457455, 624.5160000999172, 3960.584138665456, 4077.89805254871, 4080.2451546464, 4144.70987030911, 4156.189543039139, 57179.42820571824, 58971.692547670056, 100689.0, 104708.0, 104991.47504262583, 55556.0, 85335.0, 85752.57123714342, 86204.56897715597, 86309.56845215734, 43802.0, 45356.0, 59553.70223148856, 77985.99999999886, 78257.60871195607, 7694.615269236404, 7833.49082309648, 7848.332891704269, 7924.15678395966, 7951.443398962017, 44599.0, 46383.76808116073, 46449.76775116103, 48254.0, 48481.5151848477, 63264.68367658132, 69239.0, 69472.30527694659, 69674.65162674357, 69818.65090674514, 10635.14918806478, 11037.172212083966, 11038.558457661924, 11090.168237382068, 11120.721981950515, 11056.170787190831, 11292.548298068314, 11457.0, 11503.48234329474, 11696.473658685209, 9882.901170988198, 10512.526936288039, 11668.358240296866, 12184.390780461119, 12370.755522038555, 12082.69138358973, 12376.443060062138, 12549.811752823533, 12729.55446559366, 13374.06381553282, 9681.612735490502, 11395.544178232778, 11817.054635629302, 11940.641780746591, 12436.502539898303, 10100.595976161165, 10140.695779126638, 10285.74285642865, 10520.78958420812, 11107.666769996913, 9262.72211833646, 10584.788304233718, 11054.613088541862, 11253.943730281297, 11278.718032049264], "value": 6566.362463199316, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 110.0, 115.0, 114.0, 116.0, 117.0, 115.0, 117.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 153.0, 182.0, 125.0, 145.0, 159.0, 124.0, 178.0, 127.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 177.0, 162.0, 163.0, 163.0, 164.0, 163.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 78.0, 124.0, 80.0, 77.0, 75.0, 77.0, 167.0, 78.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 138.0, 86.0, 86.0, 85.0, 137.0, 86.0, 88.0, 133.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 117.0, 119.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 63.0, 63.0, 66.0, 62.0, 63.0, 64.0, 64.0, 66.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 81.0, 81.0, 80.0, 85.0, 80.0, 83.0, 90.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 130.0, 147.0, 142.0, 132.0, 142.0, 135.0, 184.0, 134.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 170.0, 168.0, 174.0, 173.0, 175.0, 179.0, 172.0, 170.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 72.0, 73.0, 68.0, 70.0, 68.0, 68.0, 66.0], "value": 69.2, "unit": "score"}]}]} 02:14:22 INFO - Return code: 0 02:14:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:14:22 ERROR - # TBPL SUCCESS # 02:14:22 INFO - Running post-action listener: _resource_record_post_action 02:14:22 INFO - ##### 02:14:22 INFO - ##### Finished run-tests step (success) 02:14:22 INFO - ##### 02:14:22 INFO - Running post-run listener: _resource_record_post_run 02:14:22 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549195776; Read time: 8; Write time: 479744 02:14:22 INFO - TinderboxPrint: CPU usage
13.3% 02:14:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:14:22 INFO - TinderboxPrint: I/O write bytes / time
549,195,776 / 479,744 02:14:22 INFO - TinderboxPrint: CPU idle
8,305.6 (86.7%) 02:14:22 INFO - TinderboxPrint: CPU user
1,222.2 (12.8%) 02:14:22 INFO - TinderboxPrint: Swap in / out
0 / 0 02:14:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250294272; Read time: 0; Write time: 301152 02:14:22 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 298901504; Read time: 0; Write time: 178592 02:14:22 INFO - Running post-run listener: _upload_blobber_files 02:14:22 INFO - Blob upload gear active. 02:14:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:14:22 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 02:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:14:23 INFO - (blobuploader) - INFO - Open directory for files ... 02:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:14:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:24 INFO - (blobuploader) - INFO - Done attempting. 02:14:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:14:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:14:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:28 INFO - (blobuploader) - INFO - Done attempting. 02:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:14:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:29 INFO - (blobuploader) - INFO - Done attempting. 02:14:29 INFO - (blobuploader) - INFO - Iteration through files over. 02:14:29 INFO - Return code: 0 02:14:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:14:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:14:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3caae486580bd3d37bd920142d65b5ff3df03f62e9a0feec5a86b558f911fd58f82a3265b6a84456c871ca6354240d93c32734400082f6b98d46958ed0c9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/977d605b91ee1bdb1e6f093910fa1962fd4ed99e62cc38e2eca1249d08f5c7a43af54eefdd2fe379b2cbdbae4033c1b4d815198f381e3e9ae62f5846a5a76839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48307da5ce7ca8a1919ba50466f20706251399f395104a4c606e23d9020f7b2af1a8af3e2261904ee646bed85fa826fad8b9116901f790911c3fc9464abfbc1b"} 02:14:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:14:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:14:29 INFO - Contents: 02:14:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3caae486580bd3d37bd920142d65b5ff3df03f62e9a0feec5a86b558f911fd58f82a3265b6a84456c871ca6354240d93c32734400082f6b98d46958ed0c9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/977d605b91ee1bdb1e6f093910fa1962fd4ed99e62cc38e2eca1249d08f5c7a43af54eefdd2fe379b2cbdbae4033c1b4d815198f381e3e9ae62f5846a5a76839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48307da5ce7ca8a1919ba50466f20706251399f395104a4c606e23d9020f7b2af1a8af3e2261904ee646bed85fa826fad8b9116901f790911c3fc9464abfbc1b"} 02:14:29 INFO - Running post-run listener: copy_logs_to_upload_dir 02:14:29 INFO - Copying logs to upload dir... 02:14:29 INFO - mkdir: /builds/slave/test/build/upload/logs 02:14:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.758665 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-12 02:14:27.685072) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 02:14:27.690965) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855 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/Fx-Team-Non-PGO/sha512/7a3caae486580bd3d37bd920142d65b5ff3df03f62e9a0feec5a86b558f911fd58f82a3265b6a84456c871ca6354240d93c32734400082f6b98d46958ed0c9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/977d605b91ee1bdb1e6f093910fa1962fd4ed99e62cc38e2eca1249d08f5c7a43af54eefdd2fe379b2cbdbae4033c1b4d815198f381e3e9ae62f5846a5a76839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48307da5ce7ca8a1919ba50466f20706251399f395104a4c606e23d9020f7b2af1a8af3e2261904ee646bed85fa826fad8b9116901f790911c3fc9464abfbc1b"} build_url:https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/BwP-gn9BTC6UOfZGyfYsPA/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/Fx-Team-Non-PGO/sha512/7a3caae486580bd3d37bd920142d65b5ff3df03f62e9a0feec5a86b558f911fd58f82a3265b6a84456c871ca6354240d93c32734400082f6b98d46958ed0c9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/977d605b91ee1bdb1e6f093910fa1962fd4ed99e62cc38e2eca1249d08f5c7a43af54eefdd2fe379b2cbdbae4033c1b4d815198f381e3e9ae62f5846a5a76839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48307da5ce7ca8a1919ba50466f20706251399f395104a4c606e23d9020f7b2af1a8af3e2261904ee646bed85fa826fad8b9116901f790911c3fc9464abfbc1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 02:14:27.716539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 02:14:27.716869) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468313621.929117-1260833855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 02:14:27.801430) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 02:14:27.801758) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 02:14:27.802044) ========= ========= Total master_lag: 0.52 =========