builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1467455492.92 results: success (0) buildid: 20160702021526 builduid: 8d3ddb3f768a4a579e91e46c28980516 revision: 49a1d28776b4a2867bb8818dfab61c352cc02f49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:32.919827) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:32.920680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:32.921046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:32.968531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:32.968903) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 03:31:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-07-02 03:31:33 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:33.101750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:33.102127) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016848 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:33.152617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 03:31:33.153064) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 49a1d28776b4a2867bb8818dfab61c352cc02f49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 49a1d28776b4a2867bb8818dfab61c352cc02f49 --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=5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 03:31:34,120 truncating revision to first 12 chars 2016-07-02 03:31:34,121 Setting DEBUG logging. 2016-07-02 03:31:34,121 attempt 1/10 2016-07-02 03:31:34,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/49a1d28776b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 03:31:35,317 unpacking tar archive at: mozilla-central-49a1d28776b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.539645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 03:31:34.707747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:34.708227) ========= script_repo_revision: 49a1d28776b4a2867bb8818dfab61c352cc02f49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:34.708851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:34.713190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 03:31:34.724935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-02 03:31:34.725263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:35 INFO - MultiFileLogger online at 20160702 03:31:35 in /builds/slave/test 03:31:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:31:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:35 INFO - {'append_to_log': False, 03:31:35 INFO - 'base_work_dir': '/builds/slave/test', 03:31:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:31:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:35 INFO - 'branch': 'Firefox-Non-PGO', 03:31:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:35 INFO - 'config_files': ('talos/linux_config.py',), 03:31:35 INFO - 'default_actions': ('clobber', 03:31:35 INFO - 'read-buildbot-config', 03:31:35 INFO - 'download-and-extract', 03:31:35 INFO - 'populate-webroot', 03:31:35 INFO - 'create-virtualenv', 03:31:35 INFO - 'install', 03:31:35 INFO - 'run-tests'), 03:31:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:35 INFO - 'download_minidump_stackwalk': True, 03:31:35 INFO - 'download_symbols': 'ondemand', 03:31:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:35 INFO - 'installer_path': 'installer.exe', 03:31:35 INFO - 'log_level': 'info', 03:31:35 INFO - 'log_name': 'talos', 03:31:35 INFO - 'log_to_console': True, 03:31:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:35 INFO - 'opt_config_files': (), 03:31:35 INFO - 'pip_index': False, 03:31:35 INFO - 'sps_profile': False, 03:31:35 INFO - 'sps_profile_interval': 0, 03:31:35 INFO - 'suite': 'dromaeojs', 03:31:35 INFO - 'system_bits': '32', 03:31:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:35 INFO - 'title': 'talos-linux64-ix-051', 03:31:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:35 INFO - 'use_talos_json': True, 03:31:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:35 INFO - 'work_dir': 'build'} 03:31:35 INFO - ##### 03:31:35 INFO - ##### Running clobber step. 03:31:35 INFO - ##### 03:31:35 INFO - Running pre-action listener: _resource_record_pre_action 03:31:35 INFO - Running main action method: clobber 03:31:35 INFO - rmtree: /builds/slave/test/build 03:31:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:36 INFO - Running post-action listener: _resource_record_post_action 03:31:36 INFO - ##### 03:31:36 INFO - ##### Finished clobber step (success) 03:31:36 INFO - ##### 03:31:36 INFO - ##### 03:31:36 INFO - ##### Running read-buildbot-config step. 03:31:36 INFO - ##### 03:31:36 INFO - Running pre-action listener: _resource_record_pre_action 03:31:36 INFO - Running main action method: read_buildbot_config 03:31:36 INFO - Using buildbot properties: 03:31:36 INFO - { 03:31:36 INFO - "project": "", 03:31:36 INFO - "product": "firefox", 03:31:36 INFO - "script_repo_revision": "production", 03:31:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:31:36 INFO - "repository": "", 03:31:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:31:36 INFO - "buildid": "20160702021526", 03:31:36 INFO - "pgo_build": "False", 03:31:36 INFO - "basedir": "/builds/slave/test", 03:31:36 INFO - "buildnumber": 631, 03:31:36 INFO - "slavename": "talos-linux64-ix-051", 03:31:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:31:36 INFO - "platform": "ubuntu64_hw", 03:31:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:31:36 INFO - "branch": "mozilla-central", 03:31:36 INFO - "repo_path": "mozilla-central", 03:31:36 INFO - "revision": "49a1d28776b4a2867bb8818dfab61c352cc02f49", 03:31:36 INFO - "stage_platform": "linux64", 03:31:36 INFO - "builduid": "8d3ddb3f768a4a579e91e46c28980516", 03:31:36 INFO - "slavebuilddir": "test" 03:31:36 INFO - } 03:31:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:31:36 INFO - Running post-action listener: _resource_record_post_action 03:31:36 INFO - ##### 03:31:36 INFO - ##### Finished read-buildbot-config step (success) 03:31:36 INFO - ##### 03:31:36 INFO - ##### 03:31:36 INFO - ##### Running download-and-extract step. 03:31:36 INFO - ##### 03:31:36 INFO - Running pre-action listener: _resource_record_pre_action 03:31:36 INFO - Running main action method: download_and_extract 03:31:36 INFO - mkdir: /builds/slave/test/build/tests 03:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:36 INFO - https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:31:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:31:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:38 INFO - Downloaded 1361 bytes. 03:31:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:31:38 INFO - Using the following test package requirements: 03:31:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:31:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'jsshell-linux-x86_64.zip'], 03:31:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:31:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:31:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:38 INFO - https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:39 INFO - Downloaded 22704234 bytes. 03:31:39 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'] 03:31:39 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 03:31:41 INFO - Return code: 0 03:31:41 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 03:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:41 INFO - https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:42 INFO - Downloaded 22704234 bytes. 03:31:42 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'] 03:31:42 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 03:31:44 INFO - Return code: 0 03:31:44 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')]} 03:31:44 INFO - https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:45 INFO - Downloaded 14405242 bytes. 03:31:45 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'] 03:31:45 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 03:31:45 INFO - Return code: 0 03:31:45 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')]} 03:31:45 INFO - https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0FaevLJS_2cKFpP9wM7PQ/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 03:31:47 INFO - Downloaded 56453624 bytes. 03:31:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:31:47 INFO - mkdir: /builds/slave/test/properties 03:31:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:47 INFO - Contents: 03:31:47 INFO - build_url:https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:31:47 INFO - Running post-action listener: _resource_record_post_action 03:31:47 INFO - Running post-action listener: set_extra_try_arguments 03:31:47 INFO - ##### 03:31:47 INFO - ##### Finished download-and-extract step (success) 03:31:47 INFO - ##### 03:31:47 INFO - ##### 03:31:47 INFO - ##### Running populate-webroot step. 03:31:47 INFO - ##### 03:31:47 INFO - Running pre-action listener: _resource_record_pre_action 03:31:47 INFO - Running main action method: populate_webroot 03:31:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:47 INFO - '--tppagecycles', 03:31:47 INFO - '7'], 03:31:47 INFO - 'tests': ['tsvgm']}}, 03:31:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['damp', 'tps']}, 03:31:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'tests': ['damp', 'tps']}, 03:31:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['dromaeo_dom']}, 03:31:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['basic_compositor_video']}, 03:31:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:31:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['a11yr', 03:31:47 INFO - 'ts_paint', 03:31:47 INFO - 'tpaint', 03:31:47 INFO - 'sessionrestore', 03:31:47 INFO - 'sessionrestore_no_auto_restore', 03:31:47 INFO - 'tabpaint']}, 03:31:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:47 INFO - 'ts_paint', 03:31:47 INFO - 'tpaint', 03:31:47 INFO - 'sessionrestore', 03:31:47 INFO - 'sessionrestore_no_auto_restore', 03:31:47 INFO - 'tabpaint']}, 03:31:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:47 INFO - 'ts_paint', 03:31:47 INFO - 'tpaint', 03:31:47 INFO - 'sessionrestore', 03:31:47 INFO - 'sessionrestore_no_auto_restore', 03:31:47 INFO - 'tabpaint']}, 03:31:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:47 INFO - 'ts_paint', 03:31:47 INFO - 'tpaint', 03:31:47 INFO - 'sessionrestore', 03:31:47 INFO - 'sessionrestore_no_auto_restore', 03:31:47 INFO - 'tabpaint']}, 03:31:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['a11yr', 03:31:47 INFO - 'ts_paint', 03:31:47 INFO - 'tpaint', 03:31:47 INFO - 'sessionrestore', 03:31:47 INFO - 'sessionrestore_no_auto_restore', 03:31:47 INFO - 'tabpaint']}, 03:31:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['a11yr', 03:31:47 INFO - 'ts_paint', 03:31:47 INFO - 'tpaint', 03:31:47 INFO - 'sessionrestore', 03:31:47 INFO - 'sessionrestore_no_auto_restore', 03:31:47 INFO - 'tabpaint']}, 03:31:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['tsvgx', 03:31:47 INFO - 'tsvgr_opacity', 03:31:47 INFO - 'tart', 03:31:47 INFO - 'tscrollx', 03:31:47 INFO - 'cart']}, 03:31:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:47 INFO - 'tsvgr_opacity', 03:31:47 INFO - 'tart', 03:31:47 INFO - 'tscrollx', 03:31:47 INFO - 'cart']}, 03:31:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'talos_options': ['--disable-e10s'], 03:31:47 INFO - 'tests': ['tp5o']}, 03:31:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'tests': ['tp5o']}, 03:31:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'talos_options': ['--disable-e10s', 03:31:47 INFO - '--xperf_path', 03:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:47 INFO - 'tests': ['tp5n']}, 03:31:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:47 INFO - 'talos_options': ['--xperf_path', 03:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:47 INFO - 'tests': ['tp5n']}}, 03:31:47 INFO - 'talos.zip': {'path': '', 03:31:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:47 INFO - Running post-action listener: _resource_record_post_action 03:31:47 INFO - ##### 03:31:47 INFO - ##### Finished populate-webroot step (success) 03:31:47 INFO - ##### 03:31:47 INFO - ##### 03:31:47 INFO - ##### Running create-virtualenv step. 03:31:47 INFO - ##### 03:31:47 INFO - Running pre-action listener: _resource_record_pre_action 03:31:47 INFO - Running main action method: create_virtualenv 03:31:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:47 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 03:31:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:47 INFO - Using real prefix '/usr' 03:31:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:50 INFO - Installing pip.................done. 03:31:50 INFO - Return code: 0 03:31:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:31:50 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 03:31:50 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 03:31:50 INFO - Using env: {'DISPLAY': ':0', 03:31:50 INFO - 'HOME': '/home/cltbld', 03:31:50 INFO - 'LANG': 'en_US.UTF-8', 03:31:50 INFO - 'LANGUAGE': 'en_US:en', 03:31:50 INFO - 'LOGNAME': 'cltbld', 03:31:50 INFO - 'MAIL': '/var/mail/cltbld', 03:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:50 INFO - 'MOZ_NO_REMOTE': '1', 03:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:50 INFO - 'NO_EM_RESTART': '1', 03:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:50 INFO - 'PWD': '/builds/slave/test', 03:31:50 INFO - 'SHELL': '/bin/bash', 03:31:50 INFO - 'SHLVL': '1', 03:31:50 INFO - 'TERM': 'linux', 03:31:50 INFO - 'TMOUT': '86400', 03:31:50 INFO - 'USER': 'cltbld', 03:31:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:50 INFO - '_': '/tools/buildbot/bin/python'} 03:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:50 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 03:31:50 INFO - Cleaning up... 03:31:50 INFO - Return code: 0 03:31:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:31:50 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 03:31:50 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 03:31:50 INFO - Using env: {'DISPLAY': ':0', 03:31:50 INFO - 'HOME': '/home/cltbld', 03:31:50 INFO - 'LANG': 'en_US.UTF-8', 03:31:50 INFO - 'LANGUAGE': 'en_US:en', 03:31:50 INFO - 'LOGNAME': 'cltbld', 03:31:50 INFO - 'MAIL': '/var/mail/cltbld', 03:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:50 INFO - 'MOZ_NO_REMOTE': '1', 03:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:50 INFO - 'NO_EM_RESTART': '1', 03:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:50 INFO - 'PWD': '/builds/slave/test', 03:31:50 INFO - 'SHELL': '/bin/bash', 03:31:50 INFO - 'SHLVL': '1', 03:31:50 INFO - 'TERM': 'linux', 03:31:50 INFO - 'TMOUT': '86400', 03:31:50 INFO - 'USER': 'cltbld', 03:31:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:50 INFO - '_': '/tools/buildbot/bin/python'} 03:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:50 INFO - Downloading/unpacking psutil>=3.1.1 03:31:50 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 03:31:50 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 03:31:50 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 03:31:50 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 03:31:50 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 03:31:50 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 03:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:52 INFO - Installing collected packages: psutil 03:31:52 INFO - Running setup.py install for psutil 03:31:52 INFO - building 'psutil._psutil_linux' extension 03:31:52 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 03:31:53 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 03:31:53 INFO - building 'psutil._psutil_posix' extension 03:31:53 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 03:31:53 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 03:31:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:53 INFO - Successfully installed psutil 03:31:53 INFO - Cleaning up... 03:31:53 INFO - Return code: 0 03:31:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:31:53 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 03:31:53 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 03:31:53 INFO - Using env: {'DISPLAY': ':0', 03:31:53 INFO - 'HOME': '/home/cltbld', 03:31:53 INFO - 'LANG': 'en_US.UTF-8', 03:31:53 INFO - 'LANGUAGE': 'en_US:en', 03:31:53 INFO - 'LOGNAME': 'cltbld', 03:31:53 INFO - 'MAIL': '/var/mail/cltbld', 03:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:53 INFO - 'MOZ_NO_REMOTE': '1', 03:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:53 INFO - 'NO_EM_RESTART': '1', 03:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:53 INFO - 'PWD': '/builds/slave/test', 03:31:53 INFO - 'SHELL': '/bin/bash', 03:31:53 INFO - 'SHLVL': '1', 03:31:53 INFO - 'TERM': 'linux', 03:31:53 INFO - 'TMOUT': '86400', 03:31:53 INFO - 'USER': 'cltbld', 03:31:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:53 INFO - '_': '/tools/buildbot/bin/python'} 03:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:55 INFO - Installing collected packages: mozsystemmonitor 03:31:55 INFO - Running setup.py install for mozsystemmonitor 03:31:55 INFO - Successfully installed mozsystemmonitor 03:31:55 INFO - Cleaning up... 03:31:55 INFO - Return code: 0 03:31:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:31:55 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 03:31:55 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 03:31:55 INFO - Using env: {'DISPLAY': ':0', 03:31:55 INFO - 'HOME': '/home/cltbld', 03:31:55 INFO - 'LANG': 'en_US.UTF-8', 03:31:55 INFO - 'LANGUAGE': 'en_US:en', 03:31:55 INFO - 'LOGNAME': 'cltbld', 03:31:55 INFO - 'MAIL': '/var/mail/cltbld', 03:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:55 INFO - 'MOZ_NO_REMOTE': '1', 03:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:55 INFO - 'NO_EM_RESTART': '1', 03:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:55 INFO - 'PWD': '/builds/slave/test', 03:31:55 INFO - 'SHELL': '/bin/bash', 03:31:55 INFO - 'SHLVL': '1', 03:31:55 INFO - 'TERM': 'linux', 03:31:55 INFO - 'TMOUT': '86400', 03:31:55 INFO - 'USER': 'cltbld', 03:31:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:55 INFO - '_': '/tools/buildbot/bin/python'} 03:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:55 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:55 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 03:31:55 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 03:31:55 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 03:31:55 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 03:31:55 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 03:31:55 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 03:31:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 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 03:31:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:58 INFO - warning: no files found matching '*.txt' 03:31:58 INFO - no previously-included directories found matching 'build' 03:31:58 INFO - no previously-included directories found matching 'dist' 03:31:58 INFO - no previously-included directories found matching '.git*' 03:31:58 INFO - Installing collected packages: jsonschema, functools32 03:31:58 INFO - Running setup.py install for functools32 03:31:58 INFO - warning: no files found matching '*.txt' 03:31:58 INFO - no previously-included directories found matching 'build' 03:31:58 INFO - no previously-included directories found matching 'dist' 03:31:58 INFO - no previously-included directories found matching '.git*' 03:31:58 INFO - Successfully installed jsonschema functools32 03:31:58 INFO - Cleaning up... 03:31:58 INFO - Return code: 0 03:31:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:58 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:31:58 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 03:31:58 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 03:31:58 INFO - Using env: {'DISPLAY': ':0', 03:31:58 INFO - 'HOME': '/home/cltbld', 03:31:58 INFO - 'LANG': 'en_US.UTF-8', 03:31:58 INFO - 'LANGUAGE': 'en_US:en', 03:31:58 INFO - 'LOGNAME': 'cltbld', 03:31:58 INFO - 'MAIL': '/var/mail/cltbld', 03:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:58 INFO - 'MOZ_NO_REMOTE': '1', 03:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:58 INFO - 'NO_EM_RESTART': '1', 03:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:58 INFO - 'PWD': '/builds/slave/test', 03:31:58 INFO - 'SHELL': '/bin/bash', 03:31:58 INFO - 'SHLVL': '1', 03:31:58 INFO - 'TERM': 'linux', 03:31:58 INFO - 'TMOUT': '86400', 03:31:58 INFO - 'USER': 'cltbld', 03:31:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:58 INFO - '_': '/tools/buildbot/bin/python'} 03:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:58 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 03:31:58 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 03:31:58 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 03:31:58 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 03:31:58 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 03:31:58 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 03:32:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:01 INFO - Downloading docopt-0.6.1.tar.gz 03:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:01 INFO - Running setup.py install for blobuploader 03:32:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:01 INFO - Running setup.py install for requests 03:32:01 INFO - Running setup.py install for docopt 03:32:01 INFO - Successfully installed blobuploader requests docopt 03:32:01 INFO - Cleaning up... 03:32:01 INFO - Return code: 0 03:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:01 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:32:01 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 03:32:01 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 03:32:01 INFO - Using env: {'DISPLAY': ':0', 03:32:01 INFO - 'HOME': '/home/cltbld', 03:32:01 INFO - 'LANG': 'en_US.UTF-8', 03:32:01 INFO - 'LANGUAGE': 'en_US:en', 03:32:01 INFO - 'LOGNAME': 'cltbld', 03:32:01 INFO - 'MAIL': '/var/mail/cltbld', 03:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:01 INFO - 'MOZ_NO_REMOTE': '1', 03:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:01 INFO - 'NO_EM_RESTART': '1', 03:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:01 INFO - 'PWD': '/builds/slave/test', 03:32:01 INFO - 'SHELL': '/bin/bash', 03:32:01 INFO - 'SHLVL': '1', 03:32:01 INFO - 'TERM': 'linux', 03:32:01 INFO - 'TMOUT': '86400', 03:32:01 INFO - 'USER': 'cltbld', 03:32:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:01 INFO - '_': '/tools/buildbot/bin/python'} 03:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:01 INFO - Running setup.py (path:/tmp/pip-x9jy4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:01 INFO - Running setup.py (path:/tmp/pip-gCNTXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:02 INFO - Running setup.py (path:/tmp/pip-RwEiGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:02 INFO - Running setup.py (path:/tmp/pip-vzZPfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:02 INFO - Running setup.py (path:/tmp/pip-MxAuqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:02 INFO - Running setup.py (path:/tmp/pip-NkZaxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:02 INFO - Running setup.py (path:/tmp/pip-0N3Cc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:02 INFO - Running setup.py (path:/tmp/pip-Ynqpwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:02 INFO - Running setup.py (path:/tmp/pip-AJIHd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:02 INFO - Running setup.py (path:/tmp/pip-Vf1B8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:02 INFO - Running setup.py (path:/tmp/pip-xEfv9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:02 INFO - Running setup.py (path:/tmp/pip-QFBNYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:02 INFO - Running setup.py (path:/tmp/pip-3ix_2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:02 INFO - Running setup.py (path:/tmp/pip-CvN7Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:02 INFO - Running setup.py (path:/tmp/pip-O5j3Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:03 INFO - Running setup.py (path:/tmp/pip-ElQCWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:03 INFO - Running setup.py (path:/tmp/pip-y_Qyyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:03 INFO - Running setup.py install for manifestparser 03:32:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozcrash 03:32:03 INFO - Running setup.py install for mozdebug 03:32:03 INFO - Running setup.py install for mozdevice 03:32:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozfile 03:32:03 INFO - Running setup.py install for mozhttpd 03:32:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozinfo 03:32:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozInstall 03:32:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:03 INFO - Running setup.py install for mozleak 03:32:04 INFO - Running setup.py install for mozlog 03:32:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Running setup.py install for moznetwork 03:32:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Running setup.py install for mozprocess 03:32:04 INFO - Running setup.py install for mozprofile 03:32:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Running setup.py install for mozrunner 03:32:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Running setup.py install for mozscreenshot 03:32:04 INFO - Running setup.py install for moztest 03:32:04 INFO - Running setup.py install for mozversion 03:32:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:04 INFO - Cleaning up... 03:32:04 INFO - Return code: 0 03:32:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:04 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')]} 03:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:04 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')]} 03:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:04 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:32:04 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 03:32:04 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 03:32:04 INFO - Using env: {'DISPLAY': ':0', 03:32:04 INFO - 'HOME': '/home/cltbld', 03:32:04 INFO - 'LANG': 'en_US.UTF-8', 03:32:04 INFO - 'LANGUAGE': 'en_US:en', 03:32:04 INFO - 'LOGNAME': 'cltbld', 03:32:04 INFO - 'MAIL': '/var/mail/cltbld', 03:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:04 INFO - 'MOZ_NO_REMOTE': '1', 03:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:04 INFO - 'NO_EM_RESTART': '1', 03:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:04 INFO - 'PWD': '/builds/slave/test', 03:32:04 INFO - 'SHELL': '/bin/bash', 03:32:04 INFO - 'SHLVL': '1', 03:32:04 INFO - 'TERM': 'linux', 03:32:04 INFO - 'TMOUT': '86400', 03:32:04 INFO - 'USER': 'cltbld', 03:32:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:04 INFO - '_': '/tools/buildbot/bin/python'} 03:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:05 INFO - Running setup.py (path:/tmp/pip-VIW4Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:05 INFO - Running setup.py (path:/tmp/pip-Rcsqkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:05 INFO - Running setup.py (path:/tmp/pip-n0Xbln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:05 INFO - Running setup.py (path:/tmp/pip-nOGI_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:05 INFO - Running setup.py (path:/tmp/pip-EeIjO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:05 INFO - Running setup.py (path:/tmp/pip-WLg92H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:05 INFO - Running setup.py (path:/tmp/pip-H2ifsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:05 INFO - Running setup.py (path:/tmp/pip-obOILD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:05 INFO - Running setup.py (path:/tmp/pip-AaCPxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:05 INFO - Running setup.py (path:/tmp/pip-uWG2YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:05 INFO - Running setup.py (path:/tmp/pip-DNP5uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:05 INFO - Running setup.py (path:/tmp/pip-4t8aaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:06 INFO - Running setup.py (path:/tmp/pip-xaBBLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:06 INFO - Running setup.py (path:/tmp/pip-vVDSUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:06 INFO - Running setup.py (path:/tmp/pip-ofigNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:06 INFO - Running setup.py (path:/tmp/pip-aPoAft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:06 INFO - Running setup.py (path:/tmp/pip-cTYsIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:06 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)) 03:32:06 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)) 03:32:06 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)) 03:32:06 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)) 03:32:06 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)) 03:32:06 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)) 03:32:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:08 INFO - Downloading blessings-1.6.tar.gz 03:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:08 INFO - Installing collected packages: blessings 03:32:08 INFO - Running setup.py install for blessings 03:32:08 INFO - Successfully installed blessings 03:32:08 INFO - Cleaning up... 03:32:08 INFO - Return code: 0 03:32:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:08 INFO - Reading from file tmpfile_stdout 03:32:08 INFO - Current package versions: 03:32:08 INFO - argparse == 1.2.1 03:32:08 INFO - blessings == 1.6 03:32:08 INFO - blobuploader == 1.2.4 03:32:08 INFO - docopt == 0.6.1 03:32:08 INFO - functools32 == 3.2.3-2 03:32:08 INFO - jsonschema == 2.5.1 03:32:08 INFO - manifestparser == 1.1 03:32:08 INFO - mozInstall == 1.12 03:32:08 INFO - mozcrash == 0.17 03:32:08 INFO - mozdebug == 0.1 03:32:08 INFO - mozdevice == 0.48 03:32:08 INFO - mozfile == 1.2 03:32:08 INFO - mozhttpd == 0.7 03:32:08 INFO - mozinfo == 0.9 03:32:08 INFO - mozleak == 0.1 03:32:08 INFO - mozlog == 3.2 03:32:08 INFO - moznetwork == 0.27 03:32:08 INFO - mozprocess == 0.22 03:32:08 INFO - mozprofile == 0.28 03:32:08 INFO - mozrunner == 6.11 03:32:08 INFO - mozscreenshot == 0.1 03:32:08 INFO - mozsystemmonitor == 0.3 03:32:08 INFO - moztest == 0.7 03:32:08 INFO - mozversion == 1.4 03:32:08 INFO - psutil == 3.1.1 03:32:08 INFO - requests == 1.2.3 03:32:08 INFO - wsgiref == 0.1.2 03:32:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:08 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 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:32:08 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 03:32:08 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 03:32:08 INFO - Using env: {'DISPLAY': ':0', 03:32:08 INFO - 'HOME': '/home/cltbld', 03:32:08 INFO - 'LANG': 'en_US.UTF-8', 03:32:08 INFO - 'LANGUAGE': 'en_US:en', 03:32:08 INFO - 'LOGNAME': 'cltbld', 03:32:08 INFO - 'MAIL': '/var/mail/cltbld', 03:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:08 INFO - 'MOZ_NO_REMOTE': '1', 03:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:08 INFO - 'NO_EM_RESTART': '1', 03:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:08 INFO - 'PWD': '/builds/slave/test', 03:32:08 INFO - 'SHELL': '/bin/bash', 03:32:08 INFO - 'SHLVL': '1', 03:32:08 INFO - 'TERM': 'linux', 03:32:08 INFO - 'TMOUT': '86400', 03:32:08 INFO - 'USER': 'cltbld', 03:32:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:08 INFO - '_': '/tools/buildbot/bin/python'} 03:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 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)) 03:32:08 INFO - Cleaning up... 03:32:08 INFO - Return code: 0 03:32:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', '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 03:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:32:08 INFO - Using env: {'DISPLAY': ':0', 03:32:08 INFO - 'HOME': '/home/cltbld', 03:32:08 INFO - 'LANG': 'en_US.UTF-8', 03:32:08 INFO - 'LANGUAGE': 'en_US:en', 03:32:08 INFO - 'LOGNAME': 'cltbld', 03:32:08 INFO - 'MAIL': '/var/mail/cltbld', 03:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:08 INFO - 'MOZ_NO_REMOTE': '1', 03:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:08 INFO - 'NO_EM_RESTART': '1', 03:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:08 INFO - 'PWD': '/builds/slave/test', 03:32:08 INFO - 'SHELL': '/bin/bash', 03:32:08 INFO - 'SHLVL': '1', 03:32:08 INFO - 'TERM': 'linux', 03:32:08 INFO - 'TMOUT': '86400', 03:32:08 INFO - 'USER': 'cltbld', 03:32:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:08 INFO - '_': '/tools/buildbot/bin/python'} 03:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:32:09 INFO - Cleaning up... 03:32:09 INFO - Return code: 0 03:32:09 INFO - Running post-action listener: _resource_record_post_action 03:32:09 INFO - Running post-action listener: _start_resource_monitoring 03:32:09 INFO - Starting resource monitoring. 03:32:09 INFO - ##### 03:32:09 INFO - ##### Finished create-virtualenv step (success) 03:32:09 INFO - ##### 03:32:09 INFO - ##### 03:32:09 INFO - ##### Running install step. 03:32:09 INFO - ##### 03:32:09 INFO - Running pre-action listener: _resource_record_pre_action 03:32:09 INFO - Running main action method: install 03:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:09 INFO - Reading from file tmpfile_stdout 03:32:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:09 INFO - Reading from file tmpfile_stdout 03:32:09 INFO - Output received: 03:32:09 INFO - Usage: mozinstall [options] installer 03:32:09 INFO - Options: 03:32:09 INFO - -h, --help show this help message and exit 03:32:09 INFO - -d DEST, --destination=DEST 03:32:09 INFO - Directory to install application into. [default: 03:32:09 INFO - "/builds/slave/test"] 03:32:09 INFO - --app=APP Application being installed. [default: firefox] 03:32:09 INFO - mkdir: /builds/slave/test/build/application 03:32:09 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'] 03:32:09 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 03:32:25 INFO - Reading from file tmpfile_stdout 03:32:25 INFO - Output received: 03:32:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:25 INFO - Running post-action listener: _resource_record_post_action 03:32:25 INFO - ##### 03:32:25 INFO - ##### Finished install step (success) 03:32:25 INFO - ##### 03:32:25 INFO - ##### 03:32:25 INFO - ##### Running run-tests step. 03:32:25 INFO - ##### 03:32:25 INFO - Running pre-action listener: _resource_record_pre_action 03:32:25 INFO - Running main action method: run_tests 03:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:25 INFO - Python 2.7.3 03:32:25 INFO - Return code: 0 03:32:25 INFO - grabbing minidump binary from tooltool 03:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad3b0>, '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 0xdae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdae740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:32:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:32:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:32:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:25 INFO - Return code: 0 03:32:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:32:25 INFO - Using env: {'DISPLAY': ':0', 03:32:25 INFO - 'HOME': '/home/cltbld', 03:32:25 INFO - 'LANG': 'en_US.UTF-8', 03:32:25 INFO - 'LANGUAGE': 'en_US:en', 03:32:25 INFO - 'LOGNAME': 'cltbld', 03:32:25 INFO - 'MAIL': '/var/mail/cltbld', 03:32:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:25 INFO - 'MOZ_NO_REMOTE': '1', 03:32:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:25 INFO - 'NO_EM_RESTART': '1', 03:32:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:25 INFO - 'PWD': '/builds/slave/test', 03:32:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:25 INFO - 'SHELL': '/bin/bash', 03:32:25 INFO - 'SHLVL': '1', 03:32:25 INFO - 'TERM': 'linux', 03:32:25 INFO - 'TMOUT': '86400', 03:32:25 INFO - 'USER': 'cltbld', 03:32:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032', 03:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:25 INFO - '_': '/tools/buildbot/bin/python'} 03:32:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:32:26 INFO - mozversion application_buildid: 20160702021526 03:32:26 INFO - mozversion application_changeset: 49a1d28776b4a2867bb8818dfab61c352cc02f49 03:32:26 INFO - mozversion application_display_name: Nightly 03:32:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:26 INFO - mozversion application_name: Firefox 03:32:26 INFO - mozversion application_remotingname: firefox 03:32:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:32:26 INFO - mozversion application_vendor: Mozilla 03:32:26 INFO - mozversion application_version: 50.0a1 03:32:26 INFO - mozversion platform_buildid: 20160702021526 03:32:26 INFO - mozversion platform_changeset: 49a1d28776b4a2867bb8818dfab61c352cc02f49 03:32:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:32:26 INFO - mozversion platform_version: 50.0a1 03:32:26 INFO - using testdate: 1467455546 03:32:26 INFO - actual date: 1467455546 03:32:26 INFO - starting webserver on 'localhost:49715' 03:32:26 INFO - SUITE-START | Running 2 tests 03:32:26 INFO - TEST-START | dromaeo_css 03:32:26 INFO - operating with platform_type : linux_ 03:32:26 INFO - Initialising browser for dromaeo_css test... 03:32:26 INFO - TEST-INFO | started process 22867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ghBUW/profile http://localhost:49715/getInfo.html) 03:32:30 INFO - PROCESS | 22867 | __metrics Screen width/height:1600/1200 03:32:30 INFO - PROCESS | 22867 | colorDepth:24 03:32:30 INFO - PROCESS | 22867 | Browser inner width/height: 1024/697 03:32:30 INFO - PROCESS | 22867 | __metrics 03:32:31 INFO - PROCESS | 22867 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:32:31 INFO - TEST-INFO | 22867: exit 0 03:32:31 INFO - Browser initialized. 03:32:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:31 INFO - TEST-INFO | started process 22948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ghBUW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:43 INFO - PROCESS | 22948 | RSS: Main: 158367744 03:32:43 INFO - PROCESS | 22948 | 03:33:35 INFO - PROCESS | 22948 | 1467455615578 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] 03:35:47 INFO - PROCESS | 22948 | Cycle 1(1): loaded http://localhost:49715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49715/tests/dromaeo/cssquery-ext.html) 03:35:48 INFO - PROCESS | 22948 | RSS: Main: 278192128 03:35:48 INFO - PROCESS | 22948 | 03:38:51 INFO - PROCESS | 22948 | Cycle 1(1): loaded http://localhost:49715/tests/dromaeo/cssquery-ext.html (next: http://localhost:49715/tests/dromaeo/cssquery-jquery.html) 03:38:51 INFO - PROCESS | 22948 | RSS: Main: 241655808 03:38:51 INFO - PROCESS | 22948 | 03:41:54 INFO - PROCESS | 22948 | Cycle 1(1): loaded http://localhost:49715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49715/tests/dromaeo/cssquery-mootools.html) 03:41:54 INFO - PROCESS | 22948 | RSS: Main: 243986432 03:41:54 INFO - PROCESS | 22948 | 03:44:56 INFO - PROCESS | 22948 | Cycle 1(1): loaded http://localhost:49715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49715/tests/dromaeo/cssquery-prototype.html) 03:44:57 INFO - PROCESS | 22948 | RSS: Main: 250085376 03:44:57 INFO - PROCESS | 22948 | 03:48:00 INFO - PROCESS | 22948 | Cycle 1(1): loaded http://localhost:49715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49715/tests/dromaeo/cssquery-yui.html) 03:48:00 INFO - PROCESS | 22948 | RSS: Main: 216518656 03:48:00 INFO - PROCESS | 22948 | 03:51:03 INFO - PROCESS | 22948 | Cycle 1(1): loaded http://localhost:49715/tests/dromaeo/cssquery-yui.html (next: http://localhost:49715/tests/dromaeo/cssquery-dojo.html) 03:51:04 INFO - PROCESS | 22948 | RSS: Main: 280342528 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | __start_tp_report 03:51:04 INFO - PROCESS | 22948 | _x_x_mozilla_page_load 03:51:04 INFO - PROCESS | 22948 | _x_x_mozilla_page_load_details 03:51:04 INFO - PROCESS | 22948 | |i|pagename|runs| 03:51:04 INFO - PROCESS | 22948 | |0;dojo.html;2603.7526434988677;2608.269684488344;2645.470905818837;2646.0474229277456;2652;4685.578297953183;4754.64340174487;4794.065157294324;4794.880127996802;4803.519648035203;4697.131030759312;4723.504032076634;4756.096341695075;4756.548127927841;4775.522447755223;4178.289690752579;4339.826406943718;4349.238883195444;4441.666874984373;4539.909201815962;4437.800298986554;4475.060237350161;4496.325551167335;4498.482674492442;4525.298578720303;4314.223439780854;4352.086061926999;4361.563843615645;4383.430154079949;4410.536893626155;4364;4382.758948257844;4389;4428.734275943454;4433.13553856998;4383.780810959471;4385.254506733863;4398.054418300081;4445.177642136216;4452.30989196675;4637.420322459692;4703.318018887277;4767.952320476786;4773.0453909218295;4788.521147885219;5134.101532231844;5152.433232344439;5160.406553246387;5162.1224391853475;5166.767495462713;5156.097682905514;5167.250748641426;5179.637425380225;5192.870178245536;5192.870178245536;4700.435947686299;4762.166620841408;4811.374521312207;4814.20565606678;4823.493533178966;5309.230161626542;5337;5339.5728341732565;5345.091334473149;5348.759305831247;4874.390701162355;5030.396352437658;5044.319016932741;5048.091343558195;5094.592432605383;5041.697498150123;5080.136376815876;5090.745462726849;5095.414027386898;5098.286239926413;5027.84916452507;5036.899262014739;5040.168372218543;5051.292819005343;5079.568236699922;4991.450940396553;4996.350474438373;5002.2496625506465;5022.221555658879;5058.595312375001;4261.509926358446;4266.445362102907;4276.679249056333;4276.807543660543;4317.9136417271475;3756.6806821419937;3759.3233218020473;3769.981150094287;3780.111673756665;3799.126200973736;4282.250606143913;4321.978390108029;4443.466783985942;4458.6878918475395;4491.640668746492;5076.6192535559985;5143.5113664201845;5144.202648589399;5164.8967020659375;5166.121759300928;4432.4237849080055;4460.799264033127;4464.687471877002;4479.59683628475;4519.435070616173;4466.9553304466535;4561.794719237642;4643.373144625432;4644.790984405709;4686.765661716969;4833.830815921426;4845.248986407112;4849.80600775965;4865.58642515376;4910.9263361050325;5105.4384017757275;5122.308488354173;5124.846254612367;5133.281340612392;5186.714730689849;4669.83655572067;4792.161371759998;4828.517148285144;4843.95156048435;4912.410510738734;5044.621653375938;5072.492750724898;5088.211327244283;5098.796048158032;5135.948640513547;5137.691738495702;5144.76848541824;5154.175331947021;5155.613329000415;5160.303359046631;4862.82980095695;4964.900701986012;4996.100701873697;4999.0501804657;5013.047520971004;4991.276264941491;5003.124453220745;5005.124103281838;5024.196128619404;5028.396592408934;4920.753962301942;4922;4939.431965324034;4982.875428114181;4985.152524070989;4867.099586576494;4899.534544218293;4909.754512274443;5022.070916880389;5065.620078494201;4941.283513890394;4944.950550494593;4948.035133149001;4977.9502204978935;4994.126027945168 03:51:04 INFO - PROCESS | 22948 | |1;ext.html;578.837925380893;585.8769658371742;586.2320360327968;586.879689663619;589.8731772668878;27888.442231155364;40005.399919001204;41526.37710434346;41676.58323416765;45791.313130303075;40210.19579608406;40535.79732101336;40542;40593.59406405935;40647.18705625886;7740.071191457033;7815.882761758564;7958.681652733883;7962.20377962202;7962.243586859239;7659.195784442609;7938.126806051329;7944.602769861513;10137.847932281022;10435.73910652236;10519.05328520433;10583.523741431616;10584.312019718733;10589.735256618607;10590.682279531587;10152.086312231897;10239.078482936571;10246.129079028291;10253.333533320347;10253.692389228336;7621.504602200839;9936.701898943043;10374.014468625468;10376.221783366278;10638.840417393745;39535.40696889549;39778.80110599429;39812.20375592501;39837.40243896315;39855.20289594221;3157.1949152966076;3241.7406607471344;3267.3955318265957;3273.067175854894;3316.502524621302;29585.408291834257;29975.850120749255;30012.69987300121;30306.84846575753;30569;3423.7945723256685;3567.233044895334;3581.498590197348;3642.7450078494253;3710.3321402147603;271288.64355678094;271609;272430;272612;273030;32732.345353092805;56049.43950560442;56704.71647641735;56745.43254567484;56787.71606141943;32934.50598241029;34345.48481772775;34723.30553388969;34827.651723482944;34834.47748283778;12278.570250041206;12350.567730129402;12364.134510584172;12438.626841194779;12442;8859.689910853218;9715.805683886283;9749.268804839665;9757.609695612238;9795.559199836025;7878.606069696492;8074.354051675852;8092.190780921978;8115.75652730419;8173.468724532886;3125.2655625927887;3129.2802655389387;3150.4486714824816;3165.354015911713;3244.870205191813;901.7114523352595;1008.5058321422597;1013.7516308504316;1028.4497793680346;1044.7962647283707;29267.829286828714;29462.705372946424;29561.26096847553;29769.25576860596;30186.396272074875;977.0522593084696;987.6444479987199;1000.6197644894893;1025.933314334566;1045.4981608827804;15448.691026179413;15571.143587102591;15650;15810.68378632444;16043.358265669476;393049;396923;397358;397628;398233;50927;52042.73978630159;52150.47849521532;52205.21692174621;52209.2168617471;970.7815741458115;1147.225622704671;1193.8686744458103;1203.0676225924979;1206.1556910163097;28741.856290718413;30314.696853031186;30459.847700761355;30671.117235341513;30747.231319217197;43332;43835;43865;43871;43931.12137757163;252898;256195;256221;256921;257846;22689.886550567142;24809.751902481465;25552.744472555038;25720.485590288463;27851.164465066082;39312.41031384589;42879.14241715211;44198.55801441945;44564.77717611391;46025.30962035505;38341.80829095948;38974.220515590096;39014.804925975186;39075;39225.411618826314;38790.224195515366;39346.803265983486;39392.80303598464;39504.60495395009;40004;37035.814820926804;37140;37949.430758539194;38484.615153848106;38581.42127868028;32573.211833728623;34820.82589587036;34836.545019190504;35103;35140.29719405546;25705;26408.339791505365;26568.202953911412;26620.86689566617;26716.19851404461 03:51:04 INFO - PROCESS | 22948 | |2;jquery.html;363.96724294813464;364.5552426040232;373.72344465095836;381.933161696703;382.10206015862707;16572.502824915242;17577.912110439447;18668.813311866877;18675.439736807883;18688.62622747546;12089.576864809733;15464;16083.195840208002;16213.918930405362;16877.24052417641;4760.404949381336;4914.680545764531;4950.826721064764;4958.826441074563;4959.52884475976;3533.681968622823;3701.98195496238;4792.089502994438;5975.312839023502;6301.968490157543;6310.495160387181;6314.400131987477;6353.872922541546;6360.840978975516;6365.936340636604;5634.239377684022;5714.257146570919;5720.1991721158865;5726.68503232322;5734.4265573442735;3435.845386957593;5092.79628814847;5326.121190003683;5335.226392173152;5496.6701997880255;13040.152390094614;13065.346732663329;13138.146020508637;16191.028538287741;21649.45876353088;1909.4653497020856;1911.8470522358177;1932.1788239997945;2052.8973551322374;2404.302752201859;9426.764330891783;9817.067378599022;14389.856101439062;14646.267686615627;15014.099154050791;1891.186789680437;1891.7635295588052;1904.1431355889767;1909.0740990619538;1925.7303977443169;67252;68621.31378686249;69762;78344;87218.56390718005;15069.397224110913;15175.913531656479;16367.263473143737;16889.746653800205;16926.23831927566;30133.931919191065;30169.849150754544;30472.695273046986;30512.69487305143;30554.84722576373;8080.878786818203;8720.171583699539;8788.384813063025;8816.955915220382;8907.153820387053;7039.964800175966;7101.183363913216;7199.3520583147765;7206.891896621555;7207.675654595556;8266.502775654242;8690.826183476294;8764.334776392465;8808.383413161146;8918.420302680304;2606.5177942080777;3056.8777248910237;3270.3132342207928;3349.681780230874;3501.448117447359;774.9535027898344;868.3270465389373;880.0027810471743;902.2691619787993;990.9347451489533;16740.246688899028;17316.567085822702;17398.565035874206;17627.823721762874;17666.381676641256;862.6980556805069;865.8181781825887;867.9956600216958;874.3835595904872;897.5871099294267;9747.268954828416;9755.951220243853;9830.705078847646;9891.208703303719;10161.39031658088;396090;401431;401724;403703;404248;80683;83598.58200708957;83912.16087839166;84324.57837710895;84413;804.5615139748851;834.2741814621197;837.4263629413871;842.806154584449;844.6072576252072;15195.240237988277;15504.069755814688;15569.68860622804;15779.921100394424;16122.435714749927;38410;38972.415413769384;39035.21929561449;40221;40712.79643601881;52516.21225681694;52657.21014184867;60867.69566152141;61688.38311616826;61691.69154154201;7530.359919406912;7843.529388236724;7845.9215407845195;7941.563214023284;7998.240167184108;8734.126587341216;11185.608503702331;11595.942020289845;11734.354610496504;11932;9863.358881672668;10248.23138264648;10329.431881246604;10337.689869303933;10564.049235568837;10199.592016319264;10538.631147909786;10677.199210059121;10708.678739637824;10945.507452164831;10297.691069267934;10514.842277365999;10927.945360273148;11009.944950275198;11155.888441115809;7883.093444253984;8034.236747508978;8063.87904181426;8113.634886430007;8168.877466837884;8000.359971202406;9563;10477.580896764044;10621.522031508446;10813.729656758644 03:51:04 INFO - PROCESS | 22948 | |3;mootools.html;1347.7641412752769;1384.7784354503278;1466.501389527561;1691.247394909266;1701.2089378439023;7494.850102997943;7907.525548467096;7996.1204267530675;8011.278984891359;8025.197480251979;6888.862222755542;7589.696412143508;7821.960890195555;7871.685132594689;7923.128455869864;2210.8341874359407;2240.8207343412487;2240.8767517786514;2240.8879556022134;2241.744623011111;2168.6530155175174;2172.7935846094674;2220.455988282873;2222.8332875034357;2224.833137514685;1905.2569497895831;1971.1819594868114;1972.644923913695;1980;2161.286775364134;2217.933461996143;2224.265992222579;2226.6882636430914;2227.654713519407;2229.7770222977733;2184.8798316092607;2186.6392045312505;2234.6648002799548;2235;2235.7764223577674;7941.5632140232265;8007;8009.9199008009755;8017.839643207103;8028.638711258008;4450.443694538183;4614.700044497131;4641.419822522184;4648.74431906245;4651.232546629802;3064.892728754483;3096.90709278722;3160.873565057395;3170.4451720948973;3174.412733644283;992.2607657295289;1004.3120462483222;1034.9172066234682;1044.3629386074488;1046.9633562825265;11011.339319640767;11041.723956901062;11059.281146725518;11070.446477676083;11079.335239885633;4136.152088821785;4216.7259128156575;4309.59058889405;4332.826686932551;4415.094905544356;9261.722148335426;9345.766355841159;9346.672866449642;9350.625974960925;9356.298277629068;4625.1443482955765;4671.205894997858;4673.813047478063;4676.859694209179;4684.437867455859;4077.8368865245056;4244.936325955113;4250.511191212988;4254.361845723166;4255.893602659959;3686.889393318205;3741.120836603396;3755.3803622402543;3794.317022935898;3825.885223443301;1159.287038471334;1172.038928078967;1181.1436708386523;1187.9940600297116;1199.740272713647;816.7223144131024;821.8274162425957;830.6699707321022;843.6878355008686;851.1531026628544;5106.617003724736;5301.3373328333955;5334.51989320963;5508.476694713996;5532;855.4653341661461;873.3493547307297;889.106448019736;895.6506962284714;905.3210092430677;3563.394222982099;3697.352963231424;3698.093966978108;3703.5370578677666;3712.8700495483067;9690.854637180448;10023.899761002296;10174.593016279414;10175.592976280866;10178;10074.546645400975;10083.546240419199;10092.697219083439;10095.495225238708;10109.241806864367;7061.611611361322;7193.568385896863;7279.162896266891;7295.562266264147;7300.488965772452;5178.766955487087;5207.140821764367;5288.444713305047;5303.867403314948;5357.249985002025;9160.6793762218;9233.676821311223;9308.813823723352;9315.534223288672;9340.673076442292;8865.468071915706;9103.726888193365;9126.315526335684;9396;9446.197073248575;7015.929840701732;7146.749863754743;7153.713851446092;7165.749198778018;7172.928270717435;7718.53688778675;7776.533407995538;7778.805529861799;7792.571408572583;7799.961000194962;6879.8130225032055;7039.366457018893;7072.5402848814665;7099.82250443743;7163.462740294394;7024.157101147691;7033.402160816388;7078.646067696492;7123.145222573325;7152.606606636685;6052.092186172109;6182.752689892354;6187.288461826947;6377.904331434939;6624.635645039569;4640.327152562927;4695.5539223773685;4717.339572459927;4749.335093087039;4830.903381932271;4735.810567577396;4749.738764367993;4778.163821331323;4806.975965120292;4853.781579828846 03:51:04 INFO - PROCESS | 22948 | |4;prototype.html;298.3644836498259;302.86522497488625;304.4231181910281;305.35874663207284;308.89497570825915;4869.951300486994;4876.87807804805;4907.11671899058;4912.901741965158;4933.45731969483;4769.833055843046;4793.250463580794;4832.3717916670785;4861.878453038676;4871.975640121804;3621.7867014550093;3738.093572278144;3749.362608356586;3823;3827.980860095696;3743.9064023399496;3804.4293355996547;3809.8095095245267;3850.4801851750076;3856.2865869814036;3772.2455508898192;3801.2777572261184;3802.619738026203;3805.6384643458964;3815.7328986970924;3609.711223102159;3633.182533929858;3750.474933509311;3766.3597188478025;3779.225258821935;3308.4871844864083;3315.933681326384;3332.3501917125927;3334.583177102862;3336.6663333666684;4653.557911998355;4660.813567457298;4662.137504561667;4686.203345431285;4700.835470758541;4204.831806727727;4239.236937351276;4265.680073994463;4279.657627389802;4283.2076065927595;4949.678270912379;4954.8694061553515;4959.925601115986;4961.751912404366;4988.102141614544;3613.1147868772055;3615.94576081359;3617.467772559219;3622.2755448910325;3651.2879988402274;4966.715310957;5178.533931946105;5192.636515443921;5204.8178313758835;5224.164133738622;3543.574771027442;3549.7515173937577;3554.8400321985573;3567.3935430976794;3572.0891172751303;3609.151849315409;3611.7110631149444;3611.837467313977;3635.2184280379847;3647.835847386874;4183.916321673611;4185.727927684691;4188;4207.326827707552;4212.368144778307;4855.441624213261;4982.750862456863;4988.825391111293;5039.748012599355;5046.949530504648;1266.9493220271086;1271.2880786759445;1286.4854058376536;1286.5046956921653;1288.342945097988;811.6307080278459;812.5084323984023;814.1573471457014;829.1128492512953;829.8547754143001;4377.409049778303;4439.378487011821;4480.834982904468;4482.103579284156;4483.349914262414;5102.489751024942;5107.591392688651;5126;5148.613853960893;5183.0670479314085;4445.844395446144;4460.30865215892;4461.442319710036;4467.687261891637;4505.571970662847;2605.5831067029185;2767.5848622706753;2767.6263704400053;2768.335599456116;2775;4907.435644900882;4930.383702037246;4935.728534930541;4940.8764780880765;4945.4312754033745;5214.5659943515075;5233.644859813129;5317.091937425988;5350.224217488442;5359.383670877821;4870.147724148189;4890.877728056756;4893.290472881484;4898.485659005824;4905.533974272438;5145.279660847409;5154.731917956087;5172.301739265151;5182.756138526802;5186.144286192736;4865.951340486691;5052.191649336089;5054.595632349477;5075.746212689424;5082.542571168465;4865.318855360323;4883.316335712932;4889.339939108318;4898.13459126415;4900.362952816111;3305.355455686118;3371.5954085509898;3382.2220889196115;3390.559227300435;3393.1347506385714;4523.502414734442;4656.321506010214;4696.272077827942;4728.108756497429;4733.715977041388;4429.955700442954;4513.458384993691;4515.735594033676;4523.457185137804;4568.79440425175;4495.280755079171;4508.63930885535;4524.547545245449;4536.977315113403;4550.476695180097;4443.222436073739;4454.307363201962;4457.554244575516;4475.239209334356;4475.552444755629;4521.728696278234;4858.319835223142;5037.337678566138;5047.924281135859;5058.519440653132;4950.282209079592;4964.726940018189;4984.800607975785;4987.600991920565;4987.80048798044 03:51:04 INFO - PROCESS | 22948 | |5;yui.html;658.9884527250671;664.2825748191954;674.2852576269158;737.0234439367839;742.5099434373311;12761.872381276184;13731.107478013922;13741.725165496684;13747.725045499084;13753.381097850595;13106.737865242689;13360.732785344311;13377.933110334434;13665.65835854104;13724.656883577916;787.3032366355759;801.4750338528273;802.8835818806269;806.762005208462;807.8384323135367;643.4337782751196;774.2644487736644;780.3718007004359;793.849168657956;804.8953636027337;843.1020962674762;845.0788640381983;846.2848892685671;846.3525403066628;846.8983721953374;485.1630936634313;834.9666013359458;837.0206857976183;837.9203975622306;838.2581415447343;574.3854076138533;598.6826981699662;602.7197353230769;612.6324205476678;613.2732711736562;13842.238676872768;13858.653533661638;13860.93069534656;13871.988561658603;13874.306284685827;11536.59621913229;11979.221350612183;12181.573644922473;12208.694782630417;12666.746665066647;12126.211796233216;12360.505579776798;12418.316992565406;12748.681282967907;13051.804222936664;3627.3652110880753;3685.4287585424304;3716.876669535253;3731.4962480065387;3773.1699026214187;57370.713146434;57733;58016;58216.41783582152;58273.417265827644;10100.848487272697;10258.846117308247;10273.589056437808;10624.36253824773;10659;19139.2344306229;19140;19149.61700765977;19150.616987660167;19163.233470661296;6860;6901.275366086589;6940.687669054904;7046.964765176243;7206.927930720625;3797.7531460454984;3844.38489841624;3911.589283125231;3937.5274967004143;4012.237674841829;2832.6600807903183;2941;2944.0284706046955;2949.8230106193696;2951.276937150412;506.4150905703918;516.7364644031571;526.9025230332325;529.0661981602475;533.5358238332675;482.48133256749134;491.56742066980826;493.9259111133287;543.804230477028;545.6398776807288;7557.056473705694;7589.316961473494;7657.655405506765;7954.284114429729;7964.442489025829;515.8271978887115;528.286812802721;552.2737600055993;552.9834104976857;554.8834744703657;4155.065110350147;4261.765602891871;4304.268274393361;4381.462582489119;4453.309736990772;102882;103717.48141259396;105582;108024;108379;89822;93893;94421.5278923601;94616.52691736497;96316;80900.59549702214;82318.58840705878;82404.58797706093;83514;85147;7136.250693677089;7823.491473054233;7892.329152022143;8016.83966320682;8084.312833409226;37156.81421592983;37734.81132594319;38418.231635367694;40832;41560;38770.347558293186;44242.33636495391;54238.457615423344;61180;63211.68394158;10382.377057376581;10641.521131549254;10684.09185219234;10796.352218866894;10817.783644327226;11517.424128793695;12438.37808109609;12595.874041259836;12690.365481725692;12777.36113194318;12405.565805196775;12405.766961946576;12695.87304126947;12957.22256664603;13210.867891321348;11656;11708.180427370002;11709.004734597314;12216.69458263515;12464.5014199431;11124.110071194447;11362.943185284352;11797.705057373634;11818.586349477728;12193.573224937085;9576.329656923948;9908.851367229641;10293.125084367613;10309.48452577383;10351.689449316533;9927.652532161339;9981.151602113901;9982.700518984442;10113.69658910234;10163.237757168094 03:51:04 INFO - PROCESS | 22948 | __end_tp_report 03:51:04 INFO - PROCESS | 22948 | __start_cc_report 03:51:04 INFO - PROCESS | 22948 | _x_x_mozilla_cycle_collect,1156 03:51:04 INFO - PROCESS | 22948 | __end_cc_report 03:51:04 INFO - PROCESS | 22948 | __startTimestamp1467456664172__endTimestamp 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | ------- Summary: start ------- 03:51:04 INFO - PROCESS | 22948 | Number of tests: 6 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | [#0] dojo.html Cycles:165 Average:4729.32 Median:4862.83 stddev:506.17 (10.4%) stddev-sans-first:479.48 03:51:04 INFO - PROCESS | 22948 | Values: 2603.8 2608.3 2645.5 2646.0 2652.0 4685.6 4754.6 4794.1 4794.9 4803.5 4697.1 4723.5 4756.1 4756.5 4775.5 4178.3 4339.8 4349.2 4441.7 4539.9 4437.8 4475.1 4496.3 4498.5 4525.3 4314.2 4352.1 4361.6 4383.4 4410.5 4364.0 4382.8 4389.0 4428.7 4433.1 4383.8 4385.3 4398.1 4445.2 4452.3 4637.4 4703.3 4768.0 4773.0 4788.5 5134.1 5152.4 5160.4 5162.1 5166.8 5156.1 5167.3 5179.6 5192.9 5192.9 4700.4 4762.2 4811.4 4814.2 4823.5 5309.2 5337.0 5339.6 5345.1 5348.8 4874.4 5030.4 5044.3 5048.1 5094.6 5041.7 5080.1 5090.7 5095.4 5098.3 5027.8 5036.9 5040.2 5051.3 5079.6 4991.5 4996.4 5002.2 5022.2 5058.6 4261.5 4266.4 4276.7 4276.8 4317.9 3756.7 3759.3 3770.0 3780.1 3799.1 4282.3 4322.0 4443.5 4458.7 4491.6 5076.6 5143.5 5144.2 5164.9 5166.1 4432.4 4460.8 4464.7 4479.6 4519.4 4467.0 4561.8 4643.4 4644.8 4686.8 4833.8 4845.2 4849.8 4865.6 4910.9 5105.4 5122.3 5124.8 5133.3 5186.7 4669.8 4792.2 4828.5 4844.0 4912.4 5044.6 5072.5 5088.2 5098.8 5135.9 5137.7 5144.8 5154.2 5155.6 5160.3 4862.8 4964.9 4996.1 4999.1 5013.0 4991.3 5003.1 5005.1 5024.2 5028.4 4920.8 4922.0 4939.4 4982.9 4985.2 4867.1 4899.5 4909.8 5022.1 5065.6 4941.3 4945.0 4948.0 4978.0 4994.1 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | [#1] ext.html Cycles:180 Average:46355.13 Median:34835.51 stddev:82834.80 (237.8%) stddev-sans-first:82995.87 03:51:04 INFO - PROCESS | 22948 | Values: 578.8 585.9 586.2 586.9 589.9 27888.4 40005.4 41526.4 41676.6 45791.3 40210.2 40535.8 40542.0 40593.6 40647.2 7740.1 7815.9 7958.7 7962.2 7962.2 7659.2 7938.1 7944.6 10137.8 10435.7 10519.1 10583.5 10584.3 10589.7 10590.7 10152.1 10239.1 10246.1 10253.3 10253.7 7621.5 9936.7 10374.0 10376.2 10638.8 39535.4 39778.8 39812.2 39837.4 39855.2 3157.2 3241.7 3267.4 3273.1 3316.5 29585.4 29975.9 30012.7 30306.8 30569.0 3423.8 3567.2 3581.5 3642.7 3710.3 271288.6 271609.0 272430.0 272612.0 273030.0 32732.3 56049.4 56704.7 56745.4 56787.7 32934.5 34345.5 34723.3 34827.7 34834.5 12278.6 12350.6 12364.1 12438.6 12442.0 8859.7 9715.8 9749.3 9757.6 9795.6 7878.6 8074.4 8092.2 8115.8 8173.5 3125.3 3129.3 3150.4 3165.4 3244.9 901.7 1008.5 1013.8 1028.4 1044.8 29267.8 29462.7 29561.3 29769.3 30186.4 977.1 987.6 1000.6 1025.9 1045.5 15448.7 15571.1 15650.0 15810.7 16043.4 393049.0 396923.0 397358.0 397628.0 398233.0 50927.0 52042.7 52150.5 52205.2 52209.2 970.8 1147.2 1193.9 1203.1 1206.2 28741.9 30314.7 30459.8 30671.1 30747.2 43332.0 43835.0 43865.0 43871.0 43931.1 252898.0 256195.0 256221.0 256921.0 257846.0 22689.9 24809.8 25552.7 25720.5 27851.2 39312.4 42879.1 44198.6 44564.8 46025.3 38341.8 38974.2 39014.8 39075.0 39225.4 38790.2 39346.8 39392.8 39504.6 40004.0 37035.8 37140.0 37949.4 38484.6 38581.4 32573.2 34820.8 34836.5 35103.0 35140.3 25705.0 26408.3 26568.2 26620.9 26716.2 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | [#2] jquery.html Cycles:180 Average:26027.71 Median:403975.50 stddev:66450.75 (16.4%) stddev-sans-first:66609.23 03:51:04 INFO - PROCESS | 22948 | Values: 364.0 364.6 373.7 381.9 382.1 16572.5 17577.9 18668.8 18675.4 18688.6 12089.6 15464.0 16083.2 16213.9 16877.2 4760.4 4914.7 4950.8 4958.8 4959.5 3533.7 3702.0 4792.1 5975.3 6302.0 6310.5 6314.4 6353.9 6360.8 6365.9 5634.2 5714.3 5720.2 5726.7 5734.4 3435.8 5092.8 5326.1 5335.2 5496.7 13040.2 13065.3 13138.1 16191.0 21649.5 1909.5 1911.8 1932.2 2052.9 2404.3 9426.8 9817.1 14389.9 14646.3 15014.1 1891.2 1891.8 1904.1 1909.1 1925.7 67252.0 68621.3 69762.0 78344.0 87218.6 15069.4 15175.9 16367.3 16889.7 16926.2 30133.9 30169.8 30472.7 30512.7 30554.8 8080.9 8720.2 8788.4 8817.0 8907.2 7040.0 7101.2 7199.4 7206.9 7207.7 8266.5 8690.8 8764.3 8808.4 8918.4 2606.5 3056.9 3270.3 3349.7 3501.4 775.0 868.3 880.0 902.3 990.9 16740.2 17316.6 17398.6 17627.8 17666.4 862.7 865.8 868.0 874.4 897.6 9747.3 9756.0 9830.7 9891.2 10161.4 396090.0 401431.0 401724.0 403703.0 404248.0 80683.0 83598.6 83912.2 84324.6 84413.0 804.6 834.3 837.4 842.8 844.6 15195.2 15504.1 15569.7 15779.9 16122.4 38410.0 38972.4 39035.2 40221.0 40712.8 52516.2 52657.2 60867.7 61688.4 61691.7 7530.4 7843.5 7845.9 7941.6 7998.2 8734.1 11185.6 11595.9 11734.4 11932.0 9863.4 10248.2 10329.4 10337.7 10564.0 10199.6 10538.6 10677.2 10708.7 10945.5 10297.7 10514.8 10927.9 11009.9 11155.9 7883.1 8034.2 8063.9 8113.6 8168.9 8000.4 9563.0 10477.6 10621.5 10813.7 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | [#3] mootools.html Cycles:180 Average:5272.93 Median:4726.58 stddev:2976.56 (63.0%) stddev-sans-first:2970.29 03:51:04 INFO - PROCESS | 22948 | Values: 1347.8 1384.8 1466.5 1691.2 1701.2 7494.9 7907.5 7996.1 8011.3 8025.2 6888.9 7589.7 7822.0 7871.7 7923.1 2210.8 2240.8 2240.9 2240.9 2241.7 2168.7 2172.8 2220.5 2222.8 2224.8 1905.3 1971.2 1972.6 1980.0 2161.3 2217.9 2224.3 2226.7 2227.7 2229.8 2184.9 2186.6 2234.7 2235.0 2235.8 7941.6 8007.0 8009.9 8017.8 8028.6 4450.4 4614.7 4641.4 4648.7 4651.2 3064.9 3096.9 3160.9 3170.4 3174.4 992.3 1004.3 1034.9 1044.4 1047.0 11011.3 11041.7 11059.3 11070.4 11079.3 4136.2 4216.7 4309.6 4332.8 4415.1 9261.7 9345.8 9346.7 9350.6 9356.3 4625.1 4671.2 4673.8 4676.9 4684.4 4077.8 4244.9 4250.5 4254.4 4255.9 3686.9 3741.1 3755.4 3794.3 3825.9 1159.3 1172.0 1181.1 1188.0 1199.7 816.7 821.8 830.7 843.7 851.2 5106.6 5301.3 5334.5 5508.5 5532.0 855.5 873.3 889.1 895.7 905.3 3563.4 3697.4 3698.1 3703.5 3712.9 9690.9 10023.9 10174.6 10175.6 10178.0 10074.5 10083.5 10092.7 10095.5 10109.2 7061.6 7193.6 7279.2 7295.6 7300.5 5178.8 5207.1 5288.4 5303.9 5357.2 9160.7 9233.7 9308.8 9315.5 9340.7 8865.5 9103.7 9126.3 9396.0 9446.2 7015.9 7146.7 7153.7 7165.7 7172.9 7718.5 7776.5 7778.8 7792.6 7800.0 6879.8 7039.4 7072.5 7099.8 7163.5 7024.2 7033.4 7078.6 7123.1 7152.6 6052.1 6182.8 6187.3 6377.9 6624.6 4640.3 4695.6 4717.3 4749.3 4830.9 4735.8 4749.7 4778.2 4807.0 4853.8 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | [#4] prototype.html Cycles:180 Average:4109.88 Median:4522.59 stddev:1187.45 (26.3%) stddev-sans-first:1155.80 03:51:04 INFO - PROCESS | 22948 | Values: 298.4 302.9 304.4 305.4 308.9 4870.0 4876.9 4907.1 4912.9 4933.5 4769.8 4793.3 4832.4 4861.9 4872.0 3621.8 3738.1 3749.4 3823.0 3828.0 3743.9 3804.4 3809.8 3850.5 3856.3 3772.2 3801.3 3802.6 3805.6 3815.7 3609.7 3633.2 3750.5 3766.4 3779.2 3308.5 3315.9 3332.4 3334.6 3336.7 4653.6 4660.8 4662.1 4686.2 4700.8 4204.8 4239.2 4265.7 4279.7 4283.2 4949.7 4954.9 4959.9 4961.8 4988.1 3613.1 3615.9 3617.5 3622.3 3651.3 4966.7 5178.5 5192.6 5204.8 5224.2 3543.6 3549.8 3554.8 3567.4 3572.1 3609.2 3611.7 3611.8 3635.2 3647.8 4183.9 4185.7 4188.0 4207.3 4212.4 4855.4 4982.8 4988.8 5039.7 5046.9 1266.9 1271.3 1286.5 1286.5 1288.3 811.6 812.5 814.2 829.1 829.9 4377.4 4439.4 4480.8 4482.1 4483.3 5102.5 5107.6 5126.0 5148.6 5183.1 4445.8 4460.3 4461.4 4467.7 4505.6 2605.6 2767.6 2767.6 2768.3 2775.0 4907.4 4930.4 4935.7 4940.9 4945.4 5214.6 5233.6 5317.1 5350.2 5359.4 4870.1 4890.9 4893.3 4898.5 4905.5 5145.3 5154.7 5172.3 5182.8 5186.1 4866.0 5052.2 5054.6 5075.7 5082.5 4865.3 4883.3 4889.3 4898.1 4900.4 3305.4 3371.6 3382.2 3390.6 3393.1 4523.5 4656.3 4696.3 4728.1 4733.7 4430.0 4513.5 4515.7 4523.5 4568.8 4495.3 4508.6 4524.5 4537.0 4550.5 4443.2 4454.3 4457.6 4475.2 4475.6 4521.7 4858.3 5037.3 5047.9 5058.5 4950.3 4964.7 4984.8 4987.6 4987.8 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - PROCESS | 22948 | [#5] yui.html Cycles:180 Average:18049.15 Median:22857.53 stddev:26595.24 (116.4%) stddev-sans-first:26637.79 03:51:04 INFO - PROCESS | 22948 | Values: 659.0 664.3 674.3 737.0 742.5 12761.9 13731.1 13741.7 13747.7 13753.4 13106.7 13360.7 13377.9 13665.7 13724.7 787.3 801.5 802.9 806.8 807.8 643.4 774.3 780.4 793.8 804.9 843.1 845.1 846.3 846.4 846.9 485.2 835.0 837.0 837.9 838.3 574.4 598.7 602.7 612.6 613.3 13842.2 13858.7 13860.9 13872.0 13874.3 11536.6 11979.2 12181.6 12208.7 12666.7 12126.2 12360.5 12418.3 12748.7 13051.8 3627.4 3685.4 3716.9 3731.5 3773.2 57370.7 57733.0 58016.0 58216.4 58273.4 10100.8 10258.8 10273.6 10624.4 10659.0 19139.2 19140.0 19149.6 19150.6 19163.2 6860.0 6901.3 6940.7 7047.0 7206.9 3797.8 3844.4 3911.6 3937.5 4012.2 2832.7 2941.0 2944.0 2949.8 2951.3 506.4 516.7 526.9 529.1 533.5 482.5 491.6 493.9 543.8 545.6 7557.1 7589.3 7657.7 7954.3 7964.4 515.8 528.3 552.3 553.0 554.9 4155.1 4261.8 4304.3 4381.5 4453.3 102882.0 103717.5 105582.0 108024.0 108379.0 89822.0 93893.0 94421.5 94616.5 96316.0 80900.6 82318.6 82404.6 83514.0 85147.0 7136.3 7823.5 7892.3 8016.8 8084.3 37156.8 37734.8 38418.2 40832.0 41560.0 38770.3 44242.3 54238.5 61180.0 63211.7 10382.4 10641.5 10684.1 10796.4 10817.8 11517.4 12438.4 12595.9 12690.4 12777.4 12405.6 12405.8 12695.9 12957.2 13210.9 11656.0 11708.2 11709.0 12216.7 12464.5 11124.1 11362.9 11797.7 11818.6 12193.6 9576.3 9908.9 10293.1 10309.5 10351.7 9927.7 9981.2 9982.7 10113.7 10163.2 03:51:04 INFO - PROCESS | 22948 | -------- Summary: end -------- 03:51:04 INFO - PROCESS | 22948 | 03:51:04 INFO - TEST-INFO | 22948: exit 0 03:51:04 INFO - TEST-OK | dromaeo_css | took 1118918ms 03:51:04 INFO - TEST-START | kraken 03:51:04 INFO - operating with platform_type : linux_ 03:51:04 INFO - Initialising browser for kraken test... 03:51:04 INFO - TEST-INFO | started process 23134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpotdm_p/profile http://localhost:49715/getInfo.html) 03:51:09 INFO - PROCESS | 23134 | __metrics Screen width/height:1600/1200 03:51:09 INFO - PROCESS | 23134 | colorDepth:24 03:51:09 INFO - PROCESS | 23134 | Browser inner width/height: 1024/697 03:51:09 INFO - PROCESS | 23134 | __metrics 03:51:09 INFO - PROCESS | 23134 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:51:10 INFO - TEST-INFO | 23134: exit 0 03:51:10 INFO - Browser initialized. 03:51:10 INFO - Running cycle 1/1 for kraken test... 03:51:10 INFO - TEST-INFO | started process 23217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpotdm_p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:22 INFO - PROCESS | 23217 | RSS: Main: 159318016 03:51:22 INFO - PROCESS | 23217 | 03:51:25 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49715/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:26 INFO - PROCESS | 23217 | RSS: Main: 217120768 03:51:26 INFO - PROCESS | 23217 | 03:51:29 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49715/tests/kraken/driver.html?testName=audio-dft) 03:51:29 INFO - PROCESS | 23217 | RSS: Main: 206168064 03:51:29 INFO - PROCESS | 23217 | 03:51:33 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49715/tests/kraken/driver.html?testName=audio-fft) 03:51:33 INFO - PROCESS | 23217 | RSS: Main: 271089664 03:51:33 INFO - PROCESS | 23217 | 03:51:35 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49715/tests/kraken/driver.html?testName=audio-oscillator) 03:51:36 INFO - PROCESS | 23217 | RSS: Main: 182091776 03:51:36 INFO - PROCESS | 23217 | 03:51:38 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:39 INFO - PROCESS | 23217 | RSS: Main: 185270272 03:51:39 INFO - PROCESS | 23217 | 03:51:42 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49715/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:43 INFO - PROCESS | 23217 | RSS: Main: 222314496 03:51:43 INFO - PROCESS | 23217 | 03:51:46 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49715/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:47 INFO - PROCESS | 23217 | RSS: Main: 222593024 03:51:47 INFO - PROCESS | 23217 | 03:51:50 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49715/tests/kraken/driver.html?testName=json-parse-financial) 03:51:50 INFO - PROCESS | 23217 | RSS: Main: 222498816 03:51:50 INFO - PROCESS | 23217 | 03:51:52 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:52 INFO - PROCESS | 23217 | RSS: Main: 209272832 03:51:52 INFO - PROCESS | 23217 | 03:51:54 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:55 INFO - PROCESS | 23217 | RSS: Main: 213102592 03:51:55 INFO - PROCESS | 23217 | 03:51:57 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:58 INFO - PROCESS | 23217 | RSS: Main: 210640896 03:51:58 INFO - PROCESS | 23217 | 03:52:00 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:01 INFO - PROCESS | 23217 | RSS: Main: 227770368 03:52:01 INFO - PROCESS | 23217 | 03:52:04 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:05 INFO - PROCESS | 23217 | RSS: Main: 226234368 03:52:05 INFO - PROCESS | 23217 | 03:52:06 INFO - PROCESS | 23217 | Cycle 1(1): loaded http://localhost:49715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49715/tests/kraken/driver.html?testName=ai-astar) 03:52:07 INFO - PROCESS | 23217 | RSS: Main: 268705792 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | __start_tp_report 03:52:07 INFO - PROCESS | 23217 | _x_x_mozilla_page_load 03:52:07 INFO - PROCESS | 23217 | _x_x_mozilla_page_load_details 03:52:07 INFO - PROCESS | 23217 | |i|pagename|runs| 03:52:07 INFO - PROCESS | 23217 | |0;ai-astar;104;115;114;114;114;114;113;112;115;114 03:52:07 INFO - PROCESS | 23217 | |1;audio-beat-detection;147;126;122;176;122;127;147;128;157;121 03:52:07 INFO - PROCESS | 23217 | |2;audio-dft;163;163;160;163;160;160;162;161;161;161 03:52:07 INFO - PROCESS | 23217 | |3;audio-fft;76;75;76;124;76;76;75;75;110;77 03:52:07 INFO - PROCESS | 23217 | |4;audio-oscillator;84;85;116;84;84;85;121;84;85;137 03:52:07 INFO - PROCESS | 23217 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;124;117;117 03:52:07 INFO - PROCESS | 23217 | |6;imaging-darkroom;146;146;146;146;148;146;146;146;147;146 03:52:07 INFO - PROCESS | 23217 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 03:52:07 INFO - PROCESS | 23217 | |8;json-parse-financial;73;62;62;63;63;63;63;63;63;63 03:52:07 INFO - PROCESS | 23217 | |9;json-stringify-tinderbox;64;64;64;64;65;63;64;64;64;65 03:52:07 INFO - PROCESS | 23217 | |10;stanford-crypto-aes;80;79;78;78;78;79;77;78;78;81 03:52:07 INFO - PROCESS | 23217 | |11;stanford-crypto-ccm;149;123;130;128;126;128;134;127;170;145 03:52:07 INFO - PROCESS | 23217 | |12;stanford-crypto-pbkdf2;166;172;166;164;164;161;163;164;164;166 03:52:07 INFO - PROCESS | 23217 | |13;stanford-crypto-sha256-iterative;71;67;67;66;66;67;67;66;67;65 03:52:07 INFO - PROCESS | 23217 | __end_tp_report 03:52:07 INFO - PROCESS | 23217 | __start_cc_report 03:52:07 INFO - PROCESS | 23217 | _x_x_mozilla_cycle_collect,1897 03:52:07 INFO - PROCESS | 23217 | __end_cc_report 03:52:07 INFO - PROCESS | 23217 | __startTimestamp1467456727068__endTimestamp 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | ------- Summary: start ------- 03:52:07 INFO - PROCESS | 23217 | Number of tests: 14 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.25 (2.8%) stddev-sans-first:0.93 03:52:07 INFO - PROCESS | 23217 | Values: 104.0 115.0 114.0 114.0 114.0 114.0 113.0 112.0 115.0 114.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:137.50 stddev:18.64 (13.6%) stddev-sans-first:19.44 03:52:07 INFO - PROCESS | 23217 | Values: 147.0 126.0 122.0 176.0 122.0 127.0 147.0 128.0 157.0 121.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.20 03:52:07 INFO - PROCESS | 23217 | Values: 163.0 163.0 160.0 163.0 160.0 160.0 162.0 161.0 161.0 161.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.00 stddev:17.71 (23.3%) stddev-sans-first:18.55 03:52:07 INFO - PROCESS | 23217 | Values: 76.0 75.0 76.0 124.0 76.0 76.0 75.0 75.0 110.0 77.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.00 stddev:20.12 (23.9%) stddev-sans-first:20.82 03:52:07 INFO - PROCESS | 23217 | Values: 84.0 85.0 116.0 84.0 84.0 85.0 121.0 84.0 85.0 137.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:2.21 (1.9%) stddev-sans-first:2.33 03:52:07 INFO - PROCESS | 23217 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 124.0 117.0 117.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:52:07 INFO - PROCESS | 23217 | Values: 146.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 147.0 146.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:52:07 INFO - PROCESS | 23217 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:63.00 stddev:3.26 (5.2%) stddev-sans-first:0.44 03:52:07 INFO - PROCESS | 23217 | Values: 73.0 62.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 03:52:07 INFO - PROCESS | 23217 | Values: 64.0 64.0 64.0 64.0 65.0 63.0 64.0 64.0 64.0 65.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.50 stddev:1.17 (1.5%) stddev-sans-first:1.13 03:52:07 INFO - PROCESS | 23217 | Values: 80.0 79.0 78.0 78.0 78.0 79.0 77.0 78.0 78.0 81.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:132.00 stddev:14.62 (11.1%) stddev-sans-first:14.73 03:52:07 INFO - PROCESS | 23217 | Values: 149.0 123.0 130.0 128.0 126.0 128.0 134.0 127.0 170.0 145.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.91 (1.8%) stddev-sans-first:3.06 03:52:07 INFO - PROCESS | 23217 | Values: 166.0 172.0 166.0 164.0 164.0 161.0 163.0 164.0 164.0 166.0 03:52:07 INFO - PROCESS | 23217 | 03:52:07 INFO - PROCESS | 23217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.60 (2.4%) stddev-sans-first:0.73 03:52:07 INFO - PROCESS | 23217 | Values: 71.0 67.0 67.0 66.0 66.0 67.0 67.0 66.0 67.0 65.0 03:52:07 INFO - PROCESS | 23217 | -------- Summary: end -------- 03:52:07 INFO - PROCESS | 23217 | 03:52:08 INFO - TEST-INFO | 23217: exit 0 03:52:08 INFO - TEST-OK | kraken | took 63137ms 03:52:08 INFO - SUITE-END | took 1182s 03:52:08 INFO - Completed test suite (00:19:42) 03:52:08 INFO - javascript benchmark 03:52:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.7526434988677, 2608.269684488344, 2645.470905818837, 2646.0474229277456, 2652.0, 4685.578297953183, 4754.64340174487, 4794.065157294324, 4794.880127996802, 4803.519648035203, 4697.131030759312, 4723.504032076634, 4756.096341695075, 4756.548127927841, 4775.522447755223, 4178.289690752579, 4339.826406943718, 4349.238883195444, 4441.666874984373, 4539.909201815962, 4437.800298986554, 4475.060237350161, 4496.325551167335, 4498.482674492442, 4525.298578720303, 4314.223439780854, 4352.086061926999, 4361.563843615645, 4383.430154079949, 4410.536893626155, 4364.0, 4382.758948257844, 4389.0, 4428.734275943454, 4433.13553856998, 4383.780810959471, 4385.254506733863, 4398.054418300081, 4445.177642136216, 4452.30989196675, 4637.420322459692, 4703.318018887277, 4767.952320476786, 4773.0453909218295, 4788.521147885219, 5134.101532231844, 5152.433232344439, 5160.406553246387, 5162.1224391853475, 5166.767495462713, 5156.097682905514, 5167.250748641426, 5179.637425380225, 5192.870178245536, 5192.870178245536, 4700.435947686299, 4762.166620841408, 4811.374521312207, 4814.20565606678, 4823.493533178966, 5309.230161626542, 5337.0, 5339.5728341732565, 5345.091334473149, 5348.759305831247, 4874.390701162355, 5030.396352437658, 5044.319016932741, 5048.091343558195, 5094.592432605383, 5041.697498150123, 5080.136376815876, 5090.745462726849, 5095.414027386898, 5098.286239926413, 5027.84916452507, 5036.899262014739, 5040.168372218543, 5051.292819005343, 5079.568236699922, 4991.450940396553, 4996.350474438373, 5002.2496625506465, 5022.221555658879, 5058.595312375001, 4261.509926358446, 4266.445362102907, 4276.679249056333, 4276.807543660543, 4317.9136417271475, 3756.6806821419937, 3759.3233218020473, 3769.981150094287, 3780.111673756665, 3799.126200973736, 4282.250606143913, 4321.978390108029, 4443.466783985942, 4458.6878918475395, 4491.640668746492, 5076.6192535559985, 5143.5113664201845, 5144.202648589399, 5164.8967020659375, 5166.121759300928, 4432.4237849080055, 4460.799264033127, 4464.687471877002, 4479.59683628475, 4519.435070616173, 4466.9553304466535, 4561.794719237642, 4643.373144625432, 4644.790984405709, 4686.765661716969, 4833.830815921426, 4845.248986407112, 4849.80600775965, 4865.58642515376, 4910.9263361050325, 5105.4384017757275, 5122.308488354173, 5124.846254612367, 5133.281340612392, 5186.714730689849, 4669.83655572067, 4792.161371759998, 4828.517148285144, 4843.95156048435, 4912.410510738734, 5044.621653375938, 5072.492750724898, 5088.211327244283, 5098.796048158032, 5135.948640513547, 5137.691738495702, 5144.76848541824, 5154.175331947021, 5155.613329000415, 5160.303359046631, 4862.82980095695, 4964.900701986012, 4996.100701873697, 4999.0501804657, 5013.047520971004, 4991.276264941491, 5003.124453220745, 5005.124103281838, 5024.196128619404, 5028.396592408934, 4920.753962301942, 4922.0, 4939.431965324034, 4982.875428114181, 4985.152524070989, 4867.099586576494, 4899.534544218293, 4909.754512274443, 5022.070916880389, 5065.620078494201, 4941.283513890394, 4944.950550494593, 4948.035133149001, 4977.9502204978935, 4994.126027945168], "value": 4696.133110474542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.837925380893, 585.8769658371742, 586.2320360327968, 586.879689663619, 589.8731772668878, 27888.442231155364, 40005.399919001204, 41526.37710434346, 41676.58323416765, 45791.313130303075, 40210.19579608406, 40535.79732101336, 40542.0, 40593.59406405935, 40647.18705625886, 7740.071191457033, 7815.882761758564, 7958.681652733883, 7962.20377962202, 7962.243586859239, 7659.195784442609, 7938.126806051329, 7944.602769861513, 10137.847932281022, 10435.73910652236, 10519.05328520433, 10583.523741431616, 10584.312019718733, 10589.735256618607, 10590.682279531587, 10152.086312231897, 10239.078482936571, 10246.129079028291, 10253.333533320347, 10253.692389228336, 7621.504602200839, 9936.701898943043, 10374.014468625468, 10376.221783366278, 10638.840417393745, 39535.40696889549, 39778.80110599429, 39812.20375592501, 39837.40243896315, 39855.20289594221, 3157.1949152966076, 3241.7406607471344, 3267.3955318265957, 3273.067175854894, 3316.502524621302, 29585.408291834257, 29975.850120749255, 30012.69987300121, 30306.84846575753, 30569.0, 3423.7945723256685, 3567.233044895334, 3581.498590197348, 3642.7450078494253, 3710.3321402147603, 271288.64355678094, 271609.0, 272430.0, 272612.0, 273030.0, 32732.345353092805, 56049.43950560442, 56704.71647641735, 56745.43254567484, 56787.71606141943, 32934.50598241029, 34345.48481772775, 34723.30553388969, 34827.651723482944, 34834.47748283778, 12278.570250041206, 12350.567730129402, 12364.134510584172, 12438.626841194779, 12442.0, 8859.689910853218, 9715.805683886283, 9749.268804839665, 9757.609695612238, 9795.559199836025, 7878.606069696492, 8074.354051675852, 8092.190780921978, 8115.75652730419, 8173.468724532886, 3125.2655625927887, 3129.2802655389387, 3150.4486714824816, 3165.354015911713, 3244.870205191813, 901.7114523352595, 1008.5058321422597, 1013.7516308504316, 1028.4497793680346, 1044.7962647283707, 29267.829286828714, 29462.705372946424, 29561.26096847553, 29769.25576860596, 30186.396272074875, 977.0522593084696, 987.6444479987199, 1000.6197644894893, 1025.933314334566, 1045.4981608827804, 15448.691026179413, 15571.143587102591, 15650.0, 15810.68378632444, 16043.358265669476, 393049.0, 396923.0, 397358.0, 397628.0, 398233.0, 50927.0, 52042.73978630159, 52150.47849521532, 52205.21692174621, 52209.2168617471, 970.7815741458115, 1147.225622704671, 1193.8686744458103, 1203.0676225924979, 1206.1556910163097, 28741.856290718413, 30314.696853031186, 30459.847700761355, 30671.117235341513, 30747.231319217197, 43332.0, 43835.0, 43865.0, 43871.0, 43931.12137757163, 252898.0, 256195.0, 256221.0, 256921.0, 257846.0, 22689.886550567142, 24809.751902481465, 25552.744472555038, 25720.485590288463, 27851.164465066082, 39312.41031384589, 42879.14241715211, 44198.55801441945, 44564.77717611391, 46025.30962035505, 38341.80829095948, 38974.220515590096, 39014.804925975186, 39075.0, 39225.411618826314, 38790.224195515366, 39346.803265983486, 39392.80303598464, 39504.60495395009, 40004.0, 37035.814820926804, 37140.0, 37949.430758539194, 38484.615153848106, 38581.42127868028, 32573.211833728623, 34820.82589587036, 34836.545019190504, 35103.0, 35140.29719405546, 25705.0, 26408.339791505365, 26568.202953911412, 26620.86689566617, 26716.19851404461], "value": 17207.914141787915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.96724294813464, 364.5552426040232, 373.72344465095836, 381.933161696703, 382.10206015862707, 16572.502824915242, 17577.912110439447, 18668.813311866877, 18675.439736807883, 18688.62622747546, 12089.576864809733, 15464.0, 16083.195840208002, 16213.918930405362, 16877.24052417641, 4760.404949381336, 4914.680545764531, 4950.826721064764, 4958.826441074563, 4959.52884475976, 3533.681968622823, 3701.98195496238, 4792.089502994438, 5975.312839023502, 6301.968490157543, 6310.495160387181, 6314.400131987477, 6353.872922541546, 6360.840978975516, 6365.936340636604, 5634.239377684022, 5714.257146570919, 5720.1991721158865, 5726.68503232322, 5734.4265573442735, 3435.845386957593, 5092.79628814847, 5326.121190003683, 5335.226392173152, 5496.6701997880255, 13040.152390094614, 13065.346732663329, 13138.146020508637, 16191.028538287741, 21649.45876353088, 1909.4653497020856, 1911.8470522358177, 1932.1788239997945, 2052.8973551322374, 2404.302752201859, 9426.764330891783, 9817.067378599022, 14389.856101439062, 14646.267686615627, 15014.099154050791, 1891.186789680437, 1891.7635295588052, 1904.1431355889767, 1909.0740990619538, 1925.7303977443169, 67252.0, 68621.31378686249, 69762.0, 78344.0, 87218.56390718005, 15069.397224110913, 15175.913531656479, 16367.263473143737, 16889.746653800205, 16926.23831927566, 30133.931919191065, 30169.849150754544, 30472.695273046986, 30512.69487305143, 30554.84722576373, 8080.878786818203, 8720.171583699539, 8788.384813063025, 8816.955915220382, 8907.153820387053, 7039.964800175966, 7101.183363913216, 7199.3520583147765, 7206.891896621555, 7207.675654595556, 8266.502775654242, 8690.826183476294, 8764.334776392465, 8808.383413161146, 8918.420302680304, 2606.5177942080777, 3056.8777248910237, 3270.3132342207928, 3349.681780230874, 3501.448117447359, 774.9535027898344, 868.3270465389373, 880.0027810471743, 902.2691619787993, 990.9347451489533, 16740.246688899028, 17316.567085822702, 17398.565035874206, 17627.823721762874, 17666.381676641256, 862.6980556805069, 865.8181781825887, 867.9956600216958, 874.3835595904872, 897.5871099294267, 9747.268954828416, 9755.951220243853, 9830.705078847646, 9891.208703303719, 10161.39031658088, 396090.0, 401431.0, 401724.0, 403703.0, 404248.0, 80683.0, 83598.58200708957, 83912.16087839166, 84324.57837710895, 84413.0, 804.5615139748851, 834.2741814621197, 837.4263629413871, 842.806154584449, 844.6072576252072, 15195.240237988277, 15504.069755814688, 15569.68860622804, 15779.921100394424, 16122.435714749927, 38410.0, 38972.415413769384, 39035.21929561449, 40221.0, 40712.79643601881, 52516.21225681694, 52657.21014184867, 60867.69566152141, 61688.38311616826, 61691.69154154201, 7530.359919406912, 7843.529388236724, 7845.9215407845195, 7941.563214023284, 7998.240167184108, 8734.126587341216, 11185.608503702331, 11595.942020289845, 11734.354610496504, 11932.0, 9863.358881672668, 10248.23138264648, 10329.431881246604, 10337.689869303933, 10564.049235568837, 10199.592016319264, 10538.631147909786, 10677.199210059121, 10708.678739637824, 10945.507452164831, 10297.691069267934, 10514.842277365999, 10927.945360273148, 11009.944950275198, 11155.888441115809, 7883.093444253984, 8034.236747508978, 8063.87904181426, 8113.634886430007, 8168.877466837884, 8000.359971202406, 9563.0, 10477.580896764044, 10621.522031508446, 10813.729656758644], "value": 8995.091702060425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.7641412752769, 1384.7784354503278, 1466.501389527561, 1691.247394909266, 1701.2089378439023, 7494.850102997943, 7907.525548467096, 7996.1204267530675, 8011.278984891359, 8025.197480251979, 6888.862222755542, 7589.696412143508, 7821.960890195555, 7871.685132594689, 7923.128455869864, 2210.8341874359407, 2240.8207343412487, 2240.8767517786514, 2240.8879556022134, 2241.744623011111, 2168.6530155175174, 2172.7935846094674, 2220.455988282873, 2222.8332875034357, 2224.833137514685, 1905.2569497895831, 1971.1819594868114, 1972.644923913695, 1980.0, 2161.286775364134, 2217.933461996143, 2224.265992222579, 2226.6882636430914, 2227.654713519407, 2229.7770222977733, 2184.8798316092607, 2186.6392045312505, 2234.6648002799548, 2235.0, 2235.7764223577674, 7941.5632140232265, 8007.0, 8009.9199008009755, 8017.839643207103, 8028.638711258008, 4450.443694538183, 4614.700044497131, 4641.419822522184, 4648.74431906245, 4651.232546629802, 3064.892728754483, 3096.90709278722, 3160.873565057395, 3170.4451720948973, 3174.412733644283, 992.2607657295289, 1004.3120462483222, 1034.9172066234682, 1044.3629386074488, 1046.9633562825265, 11011.339319640767, 11041.723956901062, 11059.281146725518, 11070.446477676083, 11079.335239885633, 4136.152088821785, 4216.7259128156575, 4309.59058889405, 4332.826686932551, 4415.094905544356, 9261.722148335426, 9345.766355841159, 9346.672866449642, 9350.625974960925, 9356.298277629068, 4625.1443482955765, 4671.205894997858, 4673.813047478063, 4676.859694209179, 4684.437867455859, 4077.8368865245056, 4244.936325955113, 4250.511191212988, 4254.361845723166, 4255.893602659959, 3686.889393318205, 3741.120836603396, 3755.3803622402543, 3794.317022935898, 3825.885223443301, 1159.287038471334, 1172.038928078967, 1181.1436708386523, 1187.9940600297116, 1199.740272713647, 816.7223144131024, 821.8274162425957, 830.6699707321022, 843.6878355008686, 851.1531026628544, 5106.617003724736, 5301.3373328333955, 5334.51989320963, 5508.476694713996, 5532.0, 855.4653341661461, 873.3493547307297, 889.106448019736, 895.6506962284714, 905.3210092430677, 3563.394222982099, 3697.352963231424, 3698.093966978108, 3703.5370578677666, 3712.8700495483067, 9690.854637180448, 10023.899761002296, 10174.593016279414, 10175.592976280866, 10178.0, 10074.546645400975, 10083.546240419199, 10092.697219083439, 10095.495225238708, 10109.241806864367, 7061.611611361322, 7193.568385896863, 7279.162896266891, 7295.562266264147, 7300.488965772452, 5178.766955487087, 5207.140821764367, 5288.444713305047, 5303.867403314948, 5357.249985002025, 9160.6793762218, 9233.676821311223, 9308.813823723352, 9315.534223288672, 9340.673076442292, 8865.468071915706, 9103.726888193365, 9126.315526335684, 9396.0, 9446.197073248575, 7015.929840701732, 7146.749863754743, 7153.713851446092, 7165.749198778018, 7172.928270717435, 7718.53688778675, 7776.533407995538, 7778.805529861799, 7792.571408572583, 7799.961000194962, 6879.8130225032055, 7039.366457018893, 7072.5402848814665, 7099.82250443743, 7163.462740294394, 7024.157101147691, 7033.402160816388, 7078.646067696492, 7123.145222573325, 7152.606606636685, 6052.092186172109, 6182.752689892354, 6187.288461826947, 6377.904331434939, 6624.635645039569, 4640.327152562927, 4695.5539223773685, 4717.339572459927, 4749.335093087039, 4830.903381932271, 4735.810567577396, 4749.738764367993, 4778.163821331323, 4806.975965120292, 4853.781579828846], "value": 4238.234608463946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.3644836498259, 302.86522497488625, 304.4231181910281, 305.35874663207284, 308.89497570825915, 4869.951300486994, 4876.87807804805, 4907.11671899058, 4912.901741965158, 4933.45731969483, 4769.833055843046, 4793.250463580794, 4832.3717916670785, 4861.878453038676, 4871.975640121804, 3621.7867014550093, 3738.093572278144, 3749.362608356586, 3823.0, 3827.980860095696, 3743.9064023399496, 3804.4293355996547, 3809.8095095245267, 3850.4801851750076, 3856.2865869814036, 3772.2455508898192, 3801.2777572261184, 3802.619738026203, 3805.6384643458964, 3815.7328986970924, 3609.711223102159, 3633.182533929858, 3750.474933509311, 3766.3597188478025, 3779.225258821935, 3308.4871844864083, 3315.933681326384, 3332.3501917125927, 3334.583177102862, 3336.6663333666684, 4653.557911998355, 4660.813567457298, 4662.137504561667, 4686.203345431285, 4700.835470758541, 4204.831806727727, 4239.236937351276, 4265.680073994463, 4279.657627389802, 4283.2076065927595, 4949.678270912379, 4954.8694061553515, 4959.925601115986, 4961.751912404366, 4988.102141614544, 3613.1147868772055, 3615.94576081359, 3617.467772559219, 3622.2755448910325, 3651.2879988402274, 4966.715310957, 5178.533931946105, 5192.636515443921, 5204.8178313758835, 5224.164133738622, 3543.574771027442, 3549.7515173937577, 3554.8400321985573, 3567.3935430976794, 3572.0891172751303, 3609.151849315409, 3611.7110631149444, 3611.837467313977, 3635.2184280379847, 3647.835847386874, 4183.916321673611, 4185.727927684691, 4188.0, 4207.326827707552, 4212.368144778307, 4855.441624213261, 4982.750862456863, 4988.825391111293, 5039.748012599355, 5046.949530504648, 1266.9493220271086, 1271.2880786759445, 1286.4854058376536, 1286.5046956921653, 1288.342945097988, 811.6307080278459, 812.5084323984023, 814.1573471457014, 829.1128492512953, 829.8547754143001, 4377.409049778303, 4439.378487011821, 4480.834982904468, 4482.103579284156, 4483.349914262414, 5102.489751024942, 5107.591392688651, 5126.0, 5148.613853960893, 5183.0670479314085, 4445.844395446144, 4460.30865215892, 4461.442319710036, 4467.687261891637, 4505.571970662847, 2605.5831067029185, 2767.5848622706753, 2767.6263704400053, 2768.335599456116, 2775.0, 4907.435644900882, 4930.383702037246, 4935.728534930541, 4940.8764780880765, 4945.4312754033745, 5214.5659943515075, 5233.644859813129, 5317.091937425988, 5350.224217488442, 5359.383670877821, 4870.147724148189, 4890.877728056756, 4893.290472881484, 4898.485659005824, 4905.533974272438, 5145.279660847409, 5154.731917956087, 5172.301739265151, 5182.756138526802, 5186.144286192736, 4865.951340486691, 5052.191649336089, 5054.595632349477, 5075.746212689424, 5082.542571168465, 4865.318855360323, 4883.316335712932, 4889.339939108318, 4898.13459126415, 4900.362952816111, 3305.355455686118, 3371.5954085509898, 3382.2220889196115, 3390.559227300435, 3393.1347506385714, 4523.502414734442, 4656.321506010214, 4696.272077827942, 4728.108756497429, 4733.715977041388, 4429.955700442954, 4513.458384993691, 4515.735594033676, 4523.457185137804, 4568.79440425175, 4495.280755079171, 4508.63930885535, 4524.547545245449, 4536.977315113403, 4550.476695180097, 4443.222436073739, 4454.307363201962, 4457.554244575516, 4475.239209334356, 4475.552444755629, 4521.728696278234, 4858.319835223142, 5037.337678566138, 5047.924281135859, 5058.519440653132, 4950.282209079592, 4964.726940018189, 4984.800607975785, 4987.600991920565, 4987.80048798044], "value": 3734.504480694256, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.9884527250671, 664.2825748191954, 674.2852576269158, 737.0234439367839, 742.5099434373311, 12761.872381276184, 13731.107478013922, 13741.725165496684, 13747.725045499084, 13753.381097850595, 13106.737865242689, 13360.732785344311, 13377.933110334434, 13665.65835854104, 13724.656883577916, 787.3032366355759, 801.4750338528273, 802.8835818806269, 806.762005208462, 807.8384323135367, 643.4337782751196, 774.2644487736644, 780.3718007004359, 793.849168657956, 804.8953636027337, 843.1020962674762, 845.0788640381983, 846.2848892685671, 846.3525403066628, 846.8983721953374, 485.1630936634313, 834.9666013359458, 837.0206857976183, 837.9203975622306, 838.2581415447343, 574.3854076138533, 598.6826981699662, 602.7197353230769, 612.6324205476678, 613.2732711736562, 13842.238676872768, 13858.653533661638, 13860.93069534656, 13871.988561658603, 13874.306284685827, 11536.59621913229, 11979.221350612183, 12181.573644922473, 12208.694782630417, 12666.746665066647, 12126.211796233216, 12360.505579776798, 12418.316992565406, 12748.681282967907, 13051.804222936664, 3627.3652110880753, 3685.4287585424304, 3716.876669535253, 3731.4962480065387, 3773.1699026214187, 57370.713146434, 57733.0, 58016.0, 58216.41783582152, 58273.417265827644, 10100.848487272697, 10258.846117308247, 10273.589056437808, 10624.36253824773, 10659.0, 19139.2344306229, 19140.0, 19149.61700765977, 19150.616987660167, 19163.233470661296, 6860.0, 6901.275366086589, 6940.687669054904, 7046.964765176243, 7206.927930720625, 3797.7531460454984, 3844.38489841624, 3911.589283125231, 3937.5274967004143, 4012.237674841829, 2832.6600807903183, 2941.0, 2944.0284706046955, 2949.8230106193696, 2951.276937150412, 506.4150905703918, 516.7364644031571, 526.9025230332325, 529.0661981602475, 533.5358238332675, 482.48133256749134, 491.56742066980826, 493.9259111133287, 543.804230477028, 545.6398776807288, 7557.056473705694, 7589.316961473494, 7657.655405506765, 7954.284114429729, 7964.442489025829, 515.8271978887115, 528.286812802721, 552.2737600055993, 552.9834104976857, 554.8834744703657, 4155.065110350147, 4261.765602891871, 4304.268274393361, 4381.462582489119, 4453.309736990772, 102882.0, 103717.48141259396, 105582.0, 108024.0, 108379.0, 89822.0, 93893.0, 94421.5278923601, 94616.52691736497, 96316.0, 80900.59549702214, 82318.58840705878, 82404.58797706093, 83514.0, 85147.0, 7136.250693677089, 7823.491473054233, 7892.329152022143, 8016.83966320682, 8084.312833409226, 37156.81421592983, 37734.81132594319, 38418.231635367694, 40832.0, 41560.0, 38770.347558293186, 44242.33636495391, 54238.457615423344, 61180.0, 63211.68394158, 10382.377057376581, 10641.521131549254, 10684.09185219234, 10796.352218866894, 10817.783644327226, 11517.424128793695, 12438.37808109609, 12595.874041259836, 12690.365481725692, 12777.36113194318, 12405.565805196775, 12405.766961946576, 12695.87304126947, 12957.22256664603, 13210.867891321348, 11656.0, 11708.180427370002, 11709.004734597314, 12216.69458263515, 12464.5014199431, 11124.110071194447, 11362.943185284352, 11797.705057373634, 11818.586349477728, 12193.573224937085, 9576.329656923948, 9908.851367229641, 10293.125084367613, 10309.48452577383, 10351.689449316533, 9927.652532161339, 9981.151602113901, 9982.700518984442, 10113.69658910234, 10163.237757168094], "value": 6604.59570634792, "unit": "score"}], "name": "dromaeo_css", "value": 6508.257998012256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 112.0, 115.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 122.0, 176.0, 122.0, 127.0, 147.0, 128.0, 157.0, 121.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 160.0, 163.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 124.0, 76.0, 76.0, 75.0, 75.0, 110.0, 77.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 84.0, 84.0, 85.0, 121.0, 84.0, 85.0, 137.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 124.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 78.0, 79.0, 77.0, 78.0, 78.0, 81.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 130.0, 128.0, 126.0, 128.0, 134.0, 127.0, 170.0, 145.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 166.0, 164.0, 164.0, 161.0, 163.0, 164.0, 164.0, 166.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1525.3, "alertThreshold": 2.0}]} 03:52:08 INFO - Return code: 0 03:52:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:52:08 INFO - # TBPL SUCCESS # 03:52:08 INFO - Running post-action listener: _resource_record_post_action 03:52:08 INFO - ##### 03:52:08 INFO - ##### Finished run-tests step (success) 03:52:08 INFO - ##### 03:52:08 INFO - Running post-run listener: _resource_record_post_run 03:52:08 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548659200; Read time: 64; Write time: 443908 03:52:08 INFO - TinderboxPrint: CPU usage
13.0% 03:52:08 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 64 03:52:08 INFO - TinderboxPrint: I/O write bytes / time
548,659,200 / 443,908 03:52:08 INFO - TinderboxPrint: CPU idle
8,325.3 (87.0%) 03:52:08 INFO - TinderboxPrint: CPU user
1,203.8 (12.6%) 03:52:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:52:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261242880; Read time: 0; Write time: 248812 03:52:08 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287416320; Read time: 52; Write time: 195096 03:52:09 INFO - Running post-run listener: _upload_blobber_files 03:52:09 INFO - Blob upload gear active. 03:52:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:09 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 03:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:52:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:10 INFO - (blobuploader) - INFO - Done attempting. 03:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:52:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:11 INFO - (blobuploader) - INFO - Done attempting. 03:52:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:52:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:14 INFO - (blobuploader) - INFO - Done attempting. 03:52:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:14 INFO - Return code: 0 03:52:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7bc49eb5c3d73b04e4fb7597339f702f252233a9268da2e6197267462ef1edf8a7cda0b014857f547c5b6e8b7f50be1800e531672ead738e32926913f950adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb58b5365f0afc82ff34569d2a9b5a88525a3b9477790ac3039083b14fb16124957091a1d941b4189970fba161873b86cebb4cfe26f2df6a383127b4f43b67c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95ab62721ddbf5c512e7902b6fef957e69d4e860cbb1ef45bf120a04097000b0a2fdbedf2df338efcd367469ca4a70b7b0f5265a8f6270c9d7fb834eed741a0d"} 03:52:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:14 INFO - Contents: 03:52:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7bc49eb5c3d73b04e4fb7597339f702f252233a9268da2e6197267462ef1edf8a7cda0b014857f547c5b6e8b7f50be1800e531672ead738e32926913f950adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb58b5365f0afc82ff34569d2a9b5a88525a3b9477790ac3039083b14fb16124957091a1d941b4189970fba161873b86cebb4cfe26f2df6a383127b4f43b67c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95ab62721ddbf5c512e7902b6fef957e69d4e860cbb1ef45bf120a04097000b0a2fdbedf2df338efcd367469ca4a70b7b0f5265a8f6270c9d7fb834eed741a0d"} 03:52:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:14 INFO - Copying logs to upload dir... 03:52:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.072505 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-02 03:52:13.807938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 03:52:13.811891) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7bc49eb5c3d73b04e4fb7597339f702f252233a9268da2e6197267462ef1edf8a7cda0b014857f547c5b6e8b7f50be1800e531672ead738e32926913f950adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb58b5365f0afc82ff34569d2a9b5a88525a3b9477790ac3039083b14fb16124957091a1d941b4189970fba161873b86cebb4cfe26f2df6a383127b4f43b67c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95ab62721ddbf5c512e7902b6fef957e69d4e860cbb1ef45bf120a04097000b0a2fdbedf2df338efcd367469ca4a70b7b0f5265a8f6270c9d7fb834eed741a0d"} build_url:https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/M0FaevLJS_2cKFpP9wM7PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7bc49eb5c3d73b04e4fb7597339f702f252233a9268da2e6197267462ef1edf8a7cda0b014857f547c5b6e8b7f50be1800e531672ead738e32926913f950adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb58b5365f0afc82ff34569d2a9b5a88525a3b9477790ac3039083b14fb16124957091a1d941b4189970fba161873b86cebb4cfe26f2df6a383127b4f43b67c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95ab62721ddbf5c512e7902b6fef957e69d4e860cbb1ef45bf120a04097000b0a2fdbedf2df338efcd367469ca4a70b7b0f5265a8f6270c9d7fb834eed741a0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 03:52:13.845386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 03:52:13.846014) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467445346.90530-1200361032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 03:52:13.928730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 03:52:13.929144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 03:52:13.929523) ========= ========= Total master_lag: 0.18 =========