builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1467861257.97 results: success (0) buildid: 20160706184624 builduid: aa66301bdf644627aa0cce4d7f73572c revision: 091b06284ffed4de98e00de2895e45195c3e70b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:17.972907) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:17.973393) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:17.973782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:18.006288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:18.006584) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 20:14:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-06 20:14:18 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:18.119536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:18.120339) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015516 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:18.177948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 20:14:18.178802) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 091b06284ffed4de98e00de2895e45195c3e70b3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 091b06284ffed4de98e00de2895e45195c3e70b3 --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=edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 20:14:18,414 truncating revision to first 12 chars 2016-07-06 20:14:18,414 Setting DEBUG logging. 2016-07-06 20:14:18,414 attempt 1/10 2016-07-06 20:14:18,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/091b06284ffe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 20:14:19,583 unpacking tar archive at: fx-team-091b06284ffe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 20:14:19.770194) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:19.770525) ========= script_repo_revision: 091b06284ffed4de98e00de2895e45195c3e70b3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:19.770968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:19.771317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 20:14:19.782487) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-06 20:14:19.782803) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:20 INFO - MultiFileLogger online at 20160706 20:14:20 in /builds/slave/test 20:14:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:14:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:20 INFO - {'append_to_log': False, 20:14:20 INFO - 'base_work_dir': '/builds/slave/test', 20:14:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:14:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:20 INFO - 'branch': 'Fx-Team-Non-PGO', 20:14:20 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:20 INFO - 'config_files': ('talos/linux_config.py',), 20:14:20 INFO - 'default_actions': ('clobber', 20:14:20 INFO - 'read-buildbot-config', 20:14:20 INFO - 'download-and-extract', 20:14:20 INFO - 'populate-webroot', 20:14:20 INFO - 'create-virtualenv', 20:14:20 INFO - 'install', 20:14:20 INFO - 'run-tests'), 20:14:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:20 INFO - 'download_minidump_stackwalk': True, 20:14:20 INFO - 'download_symbols': 'ondemand', 20:14:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:14:20 INFO - 'tooltool.py': '/tools/tooltool.py', 20:14:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:14:20 INFO - '/tools/misc-python/virtualenv.py')}, 20:14:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:20 INFO - 'installer_path': 'installer.exe', 20:14:20 INFO - 'log_level': 'info', 20:14:20 INFO - 'log_name': 'talos', 20:14:20 INFO - 'log_to_console': True, 20:14:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:20 INFO - 'opt_config_files': (), 20:14:20 INFO - 'pip_index': False, 20:14:20 INFO - 'sps_profile': False, 20:14:20 INFO - 'sps_profile_interval': 0, 20:14:20 INFO - 'suite': 'dromaeojs-e10s', 20:14:20 INFO - 'system_bits': '32', 20:14:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:20 INFO - 'title': 'talos-linux64-ix-033', 20:14:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:20 INFO - 'use_talos_json': True, 20:14:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:20 INFO - 'work_dir': 'build'} 20:14:20 INFO - ##### 20:14:20 INFO - ##### Running clobber step. 20:14:20 INFO - ##### 20:14:20 INFO - Running pre-action listener: _resource_record_pre_action 20:14:20 INFO - Running main action method: clobber 20:14:20 INFO - rmtree: /builds/slave/test/build 20:14:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:20 INFO - Running post-action listener: _resource_record_post_action 20:14:20 INFO - ##### 20:14:20 INFO - ##### Finished clobber step (success) 20:14:20 INFO - ##### 20:14:20 INFO - ##### 20:14:20 INFO - ##### Running read-buildbot-config step. 20:14:20 INFO - ##### 20:14:20 INFO - Running pre-action listener: _resource_record_pre_action 20:14:20 INFO - Running main action method: read_buildbot_config 20:14:20 INFO - Using buildbot properties: 20:14:20 INFO - { 20:14:20 INFO - "project": "", 20:14:20 INFO - "product": "firefox", 20:14:20 INFO - "script_repo_revision": "production", 20:14:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:14:20 INFO - "repository": "", 20:14:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 20:14:20 INFO - "buildid": "20160706184624", 20:14:20 INFO - "pgo_build": "False", 20:14:20 INFO - "basedir": "/builds/slave/test", 20:14:20 INFO - "buildnumber": 1463, 20:14:20 INFO - "slavename": "talos-linux64-ix-033", 20:14:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:14:20 INFO - "platform": "ubuntu64_hw", 20:14:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:14:20 INFO - "branch": "fx-team", 20:14:20 INFO - "repo_path": "integration/fx-team", 20:14:20 INFO - "revision": "091b06284ffed4de98e00de2895e45195c3e70b3", 20:14:20 INFO - "stage_platform": "linux64", 20:14:20 INFO - "builduid": "aa66301bdf644627aa0cce4d7f73572c", 20:14:20 INFO - "slavebuilddir": "test" 20:14:20 INFO - } 20:14:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:14:20 INFO - Running post-action listener: _resource_record_post_action 20:14:20 INFO - ##### 20:14:20 INFO - ##### Finished read-buildbot-config step (success) 20:14:20 INFO - ##### 20:14:20 INFO - ##### 20:14:20 INFO - ##### Running download-and-extract step. 20:14:20 INFO - ##### 20:14:20 INFO - Running pre-action listener: _resource_record_pre_action 20:14:20 INFO - Running main action method: download_and_extract 20:14:20 INFO - mkdir: /builds/slave/test/build/tests 20:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:20 INFO - https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:14:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:23 INFO - Downloaded 1361 bytes. 20:14:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:23 INFO - Using the following test package requirements: 20:14:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:14:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:14:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'jsshell-linux-x86_64.zip'], 20:14:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:14:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:14:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:14:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:14:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:14:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:14:23 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')]} 20:14:23 INFO - https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:25 INFO - Downloaded 22733142 bytes. 20:14:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:14:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:14:26 INFO - Return code: 0 20:14:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:26 INFO - https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:28 INFO - Downloaded 22733142 bytes. 20:14:28 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'] 20:14:28 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 20:14:30 INFO - Return code: 0 20:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:30 INFO - https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:31 INFO - Downloaded 14403333 bytes. 20:14:31 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'] 20:14:31 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 20:14:31 INFO - Return code: 0 20:14:31 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')]} 20:14:31 INFO - https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/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 20:14:33 INFO - Downloaded 56583559 bytes. 20:14:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:33 INFO - mkdir: /builds/slave/test/properties 20:14:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:33 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:33 INFO - Contents: 20:14:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:33 INFO - Running post-action listener: _resource_record_post_action 20:14:33 INFO - Running post-action listener: set_extra_try_arguments 20:14:33 INFO - ##### 20:14:33 INFO - ##### Finished download-and-extract step (success) 20:14:33 INFO - ##### 20:14:33 INFO - ##### 20:14:33 INFO - ##### Running populate-webroot step. 20:14:33 INFO - ##### 20:14:33 INFO - Running pre-action listener: _resource_record_pre_action 20:14:33 INFO - Running main action method: populate_webroot 20:14:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:14:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:14:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:14:33 INFO - '--tppagecycles', 20:14:33 INFO - '7'], 20:14:33 INFO - 'tests': ['tsvgm']}}, 20:14:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:14:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:14:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['damp', 'tps']}, 20:14:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'tests': ['damp', 'tps']}, 20:14:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['dromaeo_dom']}, 20:14:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['basic_compositor_video']}, 20:14:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:14:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['a11yr', 20:14:33 INFO - 'ts_paint', 20:14:33 INFO - 'tpaint', 20:14:33 INFO - 'sessionrestore', 20:14:33 INFO - 'sessionrestore_no_auto_restore', 20:14:33 INFO - 'tabpaint']}, 20:14:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:33 INFO - 'ts_paint', 20:14:33 INFO - 'tpaint', 20:14:33 INFO - 'sessionrestore', 20:14:33 INFO - 'sessionrestore_no_auto_restore', 20:14:33 INFO - 'tabpaint']}, 20:14:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:14:33 INFO - 'ts_paint', 20:14:33 INFO - 'tpaint', 20:14:33 INFO - 'sessionrestore', 20:14:33 INFO - 'sessionrestore_no_auto_restore', 20:14:33 INFO - 'tabpaint']}, 20:14:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:14:33 INFO - 'ts_paint', 20:14:33 INFO - 'tpaint', 20:14:33 INFO - 'sessionrestore', 20:14:33 INFO - 'sessionrestore_no_auto_restore', 20:14:33 INFO - 'tabpaint']}, 20:14:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['a11yr', 20:14:33 INFO - 'ts_paint', 20:14:33 INFO - 'tpaint', 20:14:33 INFO - 'sessionrestore', 20:14:33 INFO - 'sessionrestore_no_auto_restore', 20:14:33 INFO - 'tabpaint']}, 20:14:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['a11yr', 20:14:33 INFO - 'ts_paint', 20:14:33 INFO - 'tpaint', 20:14:33 INFO - 'sessionrestore', 20:14:33 INFO - 'sessionrestore_no_auto_restore', 20:14:33 INFO - 'tabpaint']}, 20:14:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['tsvgx', 20:14:33 INFO - 'tsvgr_opacity', 20:14:33 INFO - 'tart', 20:14:33 INFO - 'tscrollx', 20:14:33 INFO - 'cart']}, 20:14:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:33 INFO - 'tsvgr_opacity', 20:14:33 INFO - 'tart', 20:14:33 INFO - 'tscrollx', 20:14:33 INFO - 'cart']}, 20:14:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'talos_options': ['--disable-e10s'], 20:14:33 INFO - 'tests': ['tp5o']}, 20:14:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'tests': ['tp5o']}, 20:14:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'talos_options': ['--disable-e10s', 20:14:33 INFO - '--xperf_path', 20:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:33 INFO - 'tests': ['tp5n']}, 20:14:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:33 INFO - 'talos_options': ['--xperf_path', 20:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:33 INFO - 'tests': ['tp5n']}}, 20:14:33 INFO - 'talos.zip': {'path': '', 20:14:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:14:33 INFO - Running post-action listener: _resource_record_post_action 20:14:33 INFO - ##### 20:14:33 INFO - ##### Finished populate-webroot step (success) 20:14:33 INFO - ##### 20:14:33 INFO - ##### 20:14:33 INFO - ##### Running create-virtualenv step. 20:14:33 INFO - ##### 20:14:33 INFO - Running pre-action listener: _resource_record_pre_action 20:14:33 INFO - Running main action method: create_virtualenv 20:14:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:33 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 20:14:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:14:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:34 INFO - Using real prefix '/usr' 20:14:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:36 INFO - Installing pip.................done. 20:14:36 INFO - Return code: 0 20:14:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:36 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:36 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 20:14:36 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 20:14:36 INFO - Using env: {'DISPLAY': ':0', 20:14:36 INFO - 'HOME': '/home/cltbld', 20:14:36 INFO - 'LANG': 'en_US.UTF-8', 20:14:36 INFO - 'LANGUAGE': 'en_US:en', 20:14:36 INFO - 'LOGNAME': 'cltbld', 20:14:36 INFO - 'MAIL': '/var/mail/cltbld', 20:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:36 INFO - 'MOZ_NO_REMOTE': '1', 20:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:36 INFO - 'NO_EM_RESTART': '1', 20:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:36 INFO - 'PWD': '/builds/slave/test', 20:14:36 INFO - 'SHELL': '/bin/bash', 20:14:36 INFO - 'SHLVL': '1', 20:14:36 INFO - 'TERM': 'linux', 20:14:36 INFO - 'TMOUT': '86400', 20:14:36 INFO - 'USER': 'cltbld', 20:14:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:36 INFO - '_': '/tools/buildbot/bin/python'} 20:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:36 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 20:14:36 INFO - Cleaning up... 20:14:36 INFO - Return code: 0 20:14:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:36 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:36 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 20:14:36 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 20:14:36 INFO - Using env: {'DISPLAY': ':0', 20:14:36 INFO - 'HOME': '/home/cltbld', 20:14:36 INFO - 'LANG': 'en_US.UTF-8', 20:14:36 INFO - 'LANGUAGE': 'en_US:en', 20:14:36 INFO - 'LOGNAME': 'cltbld', 20:14:36 INFO - 'MAIL': '/var/mail/cltbld', 20:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:36 INFO - 'MOZ_NO_REMOTE': '1', 20:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:36 INFO - 'NO_EM_RESTART': '1', 20:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:36 INFO - 'PWD': '/builds/slave/test', 20:14:36 INFO - 'SHELL': '/bin/bash', 20:14:36 INFO - 'SHLVL': '1', 20:14:36 INFO - 'TERM': 'linux', 20:14:36 INFO - 'TMOUT': '86400', 20:14:36 INFO - 'USER': 'cltbld', 20:14:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:36 INFO - '_': '/tools/buildbot/bin/python'} 20:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:36 INFO - Downloading/unpacking psutil>=3.1.1 20:14:36 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 20:14:36 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 20:14:36 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 20:14:36 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 20:14:36 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 20:14:36 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 20:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:38 INFO - Installing collected packages: psutil 20:14:38 INFO - Running setup.py install for psutil 20:14:39 INFO - building 'psutil._psutil_linux' extension 20:14:39 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 20:14:39 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 20:14:39 INFO - building 'psutil._psutil_posix' extension 20:14:39 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 20:14:39 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 20:14:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:39 INFO - Successfully installed psutil 20:14:39 INFO - Cleaning up... 20:14:39 INFO - Return code: 0 20:14:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14:39 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')]} 20:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:39 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')]} 20:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:39 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:39 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 20:14:39 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 20:14:39 INFO - Using env: {'DISPLAY': ':0', 20:14:39 INFO - 'HOME': '/home/cltbld', 20:14:39 INFO - 'LANG': 'en_US.UTF-8', 20:14:39 INFO - 'LANGUAGE': 'en_US:en', 20:14:39 INFO - 'LOGNAME': 'cltbld', 20:14:39 INFO - 'MAIL': '/var/mail/cltbld', 20:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:39 INFO - 'MOZ_NO_REMOTE': '1', 20:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:39 INFO - 'NO_EM_RESTART': '1', 20:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:39 INFO - 'PWD': '/builds/slave/test', 20:14:39 INFO - 'SHELL': '/bin/bash', 20:14:39 INFO - 'SHLVL': '1', 20:14:39 INFO - 'TERM': 'linux', 20:14:39 INFO - 'TMOUT': '86400', 20:14:39 INFO - 'USER': 'cltbld', 20:14:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:39 INFO - '_': '/tools/buildbot/bin/python'} 20:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14:39 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 20:14:39 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 20:14:39 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 20:14:39 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 20:14:39 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 20:14:39 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 20:14:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:14:41 INFO - Installing collected packages: mozsystemmonitor 20:14:41 INFO - Running setup.py install for mozsystemmonitor 20:14:41 INFO - Successfully installed mozsystemmonitor 20:14:41 INFO - Cleaning up... 20:14:41 INFO - Return code: 0 20:14:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:41 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:41 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 20:14:41 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 20:14:41 INFO - Using env: {'DISPLAY': ':0', 20:14:41 INFO - 'HOME': '/home/cltbld', 20:14:41 INFO - 'LANG': 'en_US.UTF-8', 20:14:41 INFO - 'LANGUAGE': 'en_US:en', 20:14:41 INFO - 'LOGNAME': 'cltbld', 20:14:41 INFO - 'MAIL': '/var/mail/cltbld', 20:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:41 INFO - 'MOZ_NO_REMOTE': '1', 20:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:41 INFO - 'NO_EM_RESTART': '1', 20:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:41 INFO - 'PWD': '/builds/slave/test', 20:14:41 INFO - 'SHELL': '/bin/bash', 20:14:41 INFO - 'SHLVL': '1', 20:14:41 INFO - 'TERM': 'linux', 20:14:41 INFO - 'TMOUT': '86400', 20:14:41 INFO - 'USER': 'cltbld', 20:14:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:41 INFO - '_': '/tools/buildbot/bin/python'} 20:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:42 INFO - Downloading/unpacking jsonschema==2.5.1 20:14:42 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 20:14:42 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 20:14:42 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 20:14:42 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 20:14:42 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 20:14:42 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 20:14:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:14:43 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 20:14:43 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 20:14:43 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 20:14:43 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 20:14:43 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 20:14:43 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 20:14:44 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:44 INFO - warning: no files found matching '*.txt' 20:14:44 INFO - no previously-included directories found matching 'build' 20:14:44 INFO - no previously-included directories found matching 'dist' 20:14:44 INFO - no previously-included directories found matching '.git*' 20:14:44 INFO - Installing collected packages: jsonschema, functools32 20:14:44 INFO - Running setup.py install for functools32 20:14:44 INFO - warning: no files found matching '*.txt' 20:14:44 INFO - no previously-included directories found matching 'build' 20:14:44 INFO - no previously-included directories found matching 'dist' 20:14:44 INFO - no previously-included directories found matching '.git*' 20:14:44 INFO - Successfully installed jsonschema functools32 20:14:44 INFO - Cleaning up... 20:14:44 INFO - Return code: 0 20:14:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:44 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:44 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 20:14:44 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 20:14:44 INFO - Using env: {'DISPLAY': ':0', 20:14:44 INFO - 'HOME': '/home/cltbld', 20:14:44 INFO - 'LANG': 'en_US.UTF-8', 20:14:44 INFO - 'LANGUAGE': 'en_US:en', 20:14:44 INFO - 'LOGNAME': 'cltbld', 20:14:44 INFO - 'MAIL': '/var/mail/cltbld', 20:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:44 INFO - 'MOZ_NO_REMOTE': '1', 20:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:44 INFO - 'NO_EM_RESTART': '1', 20:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:44 INFO - 'PWD': '/builds/slave/test', 20:14:44 INFO - 'SHELL': '/bin/bash', 20:14:44 INFO - 'SHLVL': '1', 20:14:44 INFO - 'TERM': 'linux', 20:14:44 INFO - 'TMOUT': '86400', 20:14:44 INFO - 'USER': 'cltbld', 20:14:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:44 INFO - '_': '/tools/buildbot/bin/python'} 20:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:47 INFO - Downloading docopt-0.6.1.tar.gz 20:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:47 INFO - Running setup.py install for blobuploader 20:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:47 INFO - Running setup.py install for requests 20:14:47 INFO - Running setup.py install for docopt 20:14:47 INFO - Successfully installed blobuploader requests docopt 20:14:47 INFO - Cleaning up... 20:14:47 INFO - Return code: 0 20:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:47 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')]} 20:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 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')]} 20:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:47 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 20:14:47 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 20:14:47 INFO - Using env: {'DISPLAY': ':0', 20:14:47 INFO - 'HOME': '/home/cltbld', 20:14:47 INFO - 'LANG': 'en_US.UTF-8', 20:14:47 INFO - 'LANGUAGE': 'en_US:en', 20:14:47 INFO - 'LOGNAME': 'cltbld', 20:14:47 INFO - 'MAIL': '/var/mail/cltbld', 20:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:47 INFO - 'MOZ_NO_REMOTE': '1', 20:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:47 INFO - 'NO_EM_RESTART': '1', 20:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:47 INFO - 'PWD': '/builds/slave/test', 20:14:47 INFO - 'SHELL': '/bin/bash', 20:14:47 INFO - 'SHLVL': '1', 20:14:47 INFO - 'TERM': 'linux', 20:14:47 INFO - 'TMOUT': '86400', 20:14:47 INFO - 'USER': 'cltbld', 20:14:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:47 INFO - '_': '/tools/buildbot/bin/python'} 20:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:48 INFO - Running setup.py (path:/tmp/pip-oprJxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:48 INFO - Running setup.py (path:/tmp/pip-NC1xnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:48 INFO - Running setup.py (path:/tmp/pip-AcixdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:48 INFO - Running setup.py (path:/tmp/pip-v9sVQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:48 INFO - Running setup.py (path:/tmp/pip-rqE6ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:48 INFO - Running setup.py (path:/tmp/pip-R6QK0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:48 INFO - Running setup.py (path:/tmp/pip-wxQs16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:48 INFO - Running setup.py (path:/tmp/pip-BjKgjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:48 INFO - Running setup.py (path:/tmp/pip-zo02I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:48 INFO - Running setup.py (path:/tmp/pip-_FQBww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:48 INFO - Running setup.py (path:/tmp/pip-dG5alC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:48 INFO - Running setup.py (path:/tmp/pip-veEFoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:48 INFO - Running setup.py (path:/tmp/pip-5EQc_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:49 INFO - Running setup.py (path:/tmp/pip-7HplUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:49 INFO - Running setup.py (path:/tmp/pip-KtBHPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:49 INFO - Running setup.py (path:/tmp/pip-OBVkf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:49 INFO - Running setup.py (path:/tmp/pip-5Rxj1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:49 INFO - Running setup.py install for manifestparser 20:14:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:49 INFO - Running setup.py install for mozcrash 20:14:49 INFO - Running setup.py install for mozdebug 20:14:49 INFO - Running setup.py install for mozdevice 20:14:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:49 INFO - Running setup.py install for mozfile 20:14:49 INFO - Running setup.py install for mozhttpd 20:14:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:49 INFO - Running setup.py install for mozinfo 20:14:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for mozInstall 20:14:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for mozleak 20:14:50 INFO - Running setup.py install for mozlog 20:14:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for moznetwork 20:14:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for mozprocess 20:14:50 INFO - Running setup.py install for mozprofile 20:14:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for mozrunner 20:14:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for mozscreenshot 20:14:50 INFO - Running setup.py install for moztest 20:14:50 INFO - Running setup.py install for mozversion 20:14:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:51 INFO - Cleaning up... 20:14:51 INFO - Return code: 0 20:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:51 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:51 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 20:14:51 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 20:14:51 INFO - Using env: {'DISPLAY': ':0', 20:14:51 INFO - 'HOME': '/home/cltbld', 20:14:51 INFO - 'LANG': 'en_US.UTF-8', 20:14:51 INFO - 'LANGUAGE': 'en_US:en', 20:14:51 INFO - 'LOGNAME': 'cltbld', 20:14:51 INFO - 'MAIL': '/var/mail/cltbld', 20:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:51 INFO - 'MOZ_NO_REMOTE': '1', 20:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:51 INFO - 'NO_EM_RESTART': '1', 20:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:51 INFO - 'PWD': '/builds/slave/test', 20:14:51 INFO - 'SHELL': '/bin/bash', 20:14:51 INFO - 'SHLVL': '1', 20:14:51 INFO - 'TERM': 'linux', 20:14:51 INFO - 'TMOUT': '86400', 20:14:51 INFO - 'USER': 'cltbld', 20:14:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:51 INFO - '_': '/tools/buildbot/bin/python'} 20:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:51 INFO - Running setup.py (path:/tmp/pip-DK3Qw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:51 INFO - Running setup.py (path:/tmp/pip-3bHYZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:51 INFO - Running setup.py (path:/tmp/pip-Gm_eYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:51 INFO - Running setup.py (path:/tmp/pip-eQBvW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:51 INFO - Running setup.py (path:/tmp/pip-JNp8a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:51 INFO - Running setup.py (path:/tmp/pip-1YYpaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:51 INFO - Running setup.py (path:/tmp/pip-TYAm7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:51 INFO - Running setup.py (path:/tmp/pip-VKxNxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:51 INFO - Running setup.py (path:/tmp/pip-hTz06f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:51 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)) 20:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:51 INFO - Running setup.py (path:/tmp/pip-RCgVkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:52 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)) 20:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:52 INFO - Running setup.py (path:/tmp/pip-8W3hgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:52 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)) 20:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:52 INFO - Running setup.py (path:/tmp/pip-MYTsBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:52 INFO - Running setup.py (path:/tmp/pip-jlEJif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:52 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)) 20:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:52 INFO - Running setup.py (path:/tmp/pip-rOtdUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:52 INFO - Running setup.py (path:/tmp/pip-IxzDdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:52 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)) 20:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:52 INFO - Running setup.py (path:/tmp/pip-LmxWS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:52 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)) 20:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:52 INFO - Running setup.py (path:/tmp/pip-kSey25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:52 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)) 20:14:52 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)) 20:14:52 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)) 20:14:52 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)) 20:14:52 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)) 20:14:52 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)) 20:14:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14:52 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 20:14:52 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 20:14:52 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 20:14:52 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 20:14:52 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 20:14:52 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 20:14:54 INFO - Downloading blessings-1.6.tar.gz 20:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:14:54 INFO - Installing collected packages: blessings 20:14:54 INFO - Running setup.py install for blessings 20:14:54 INFO - Successfully installed blessings 20:14:54 INFO - Cleaning up... 20:14:54 INFO - Return code: 0 20:14:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:54 INFO - Reading from file tmpfile_stdout 20:14:54 INFO - Current package versions: 20:14:54 INFO - argparse == 1.2.1 20:14:54 INFO - blessings == 1.6 20:14:54 INFO - blobuploader == 1.2.4 20:14:54 INFO - docopt == 0.6.1 20:14:54 INFO - functools32 == 3.2.3-2 20:14:54 INFO - jsonschema == 2.5.1 20:14:54 INFO - manifestparser == 1.1 20:14:54 INFO - mozInstall == 1.12 20:14:54 INFO - mozcrash == 0.17 20:14:54 INFO - mozdebug == 0.1 20:14:54 INFO - mozdevice == 0.48 20:14:54 INFO - mozfile == 1.2 20:14:54 INFO - mozhttpd == 0.7 20:14:54 INFO - mozinfo == 0.9 20:14:54 INFO - mozleak == 0.1 20:14:54 INFO - mozlog == 3.2 20:14:54 INFO - moznetwork == 0.27 20:14:54 INFO - mozprocess == 0.23 20:14:54 INFO - mozprofile == 0.28 20:14:54 INFO - mozrunner == 6.12 20:14:54 INFO - mozscreenshot == 0.1 20:14:54 INFO - mozsystemmonitor == 0.3 20:14:54 INFO - moztest == 0.7 20:14:54 INFO - mozversion == 1.4 20:14:54 INFO - psutil == 3.1.1 20:14:54 INFO - requests == 1.2.3 20:14:54 INFO - wsgiref == 0.1.2 20:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:54 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 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14:54 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 20:14:54 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 20:14:54 INFO - Using env: {'DISPLAY': ':0', 20:14:54 INFO - 'HOME': '/home/cltbld', 20:14:54 INFO - 'LANG': 'en_US.UTF-8', 20:14:54 INFO - 'LANGUAGE': 'en_US:en', 20:14:54 INFO - 'LOGNAME': 'cltbld', 20:14:54 INFO - 'MAIL': '/var/mail/cltbld', 20:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:54 INFO - 'MOZ_NO_REMOTE': '1', 20:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:54 INFO - 'NO_EM_RESTART': '1', 20:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:54 INFO - 'PWD': '/builds/slave/test', 20:14:54 INFO - 'SHELL': '/bin/bash', 20:14:54 INFO - 'SHLVL': '1', 20:14:54 INFO - 'TERM': 'linux', 20:14:54 INFO - 'TMOUT': '86400', 20:14:54 INFO - 'USER': 'cltbld', 20:14:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:54 INFO - '_': '/tools/buildbot/bin/python'} 20:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 INFO - Cleaning up... 20:14:55 INFO - Return code: 0 20:14:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', '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 20:14: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'] in /builds/slave/test/build 20:14: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 20:14:55 INFO - Using env: {'DISPLAY': ':0', 20:14:55 INFO - 'HOME': '/home/cltbld', 20:14:55 INFO - 'LANG': 'en_US.UTF-8', 20:14:55 INFO - 'LANGUAGE': 'en_US:en', 20:14:55 INFO - 'LOGNAME': 'cltbld', 20:14:55 INFO - 'MAIL': '/var/mail/cltbld', 20:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:55 INFO - 'MOZ_NO_REMOTE': '1', 20:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:55 INFO - 'NO_EM_RESTART': '1', 20:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:55 INFO - 'PWD': '/builds/slave/test', 20:14:55 INFO - 'SHELL': '/bin/bash', 20:14:55 INFO - 'SHLVL': '1', 20:14:55 INFO - 'TERM': 'linux', 20:14:55 INFO - 'TMOUT': '86400', 20:14:55 INFO - 'USER': 'cltbld', 20:14:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:55 INFO - '_': '/tools/buildbot/bin/python'} 20:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:14:55 INFO - Cleaning up... 20:14:55 INFO - Return code: 0 20:14:55 INFO - Running post-action listener: _resource_record_post_action 20:14:55 INFO - Running post-action listener: _start_resource_monitoring 20:14:55 INFO - Starting resource monitoring. 20:14:55 INFO - ##### 20:14:55 INFO - ##### Finished create-virtualenv step (success) 20:14:55 INFO - ##### 20:14:55 INFO - ##### 20:14:55 INFO - ##### Running install step. 20:14:55 INFO - ##### 20:14:55 INFO - Running pre-action listener: _resource_record_pre_action 20:14:55 INFO - Running main action method: install 20:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:55 INFO - Reading from file tmpfile_stdout 20:14:55 INFO - Detecting whether we're running mozinstall >=1.0... 20:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:14:55 INFO - Reading from file tmpfile_stdout 20:14:55 INFO - Output received: 20:14:55 INFO - Usage: mozinstall [options] installer 20:14:55 INFO - Options: 20:14:55 INFO - -h, --help show this help message and exit 20:14:55 INFO - -d DEST, --destination=DEST 20:14:55 INFO - Directory to install application into. [default: 20:14:55 INFO - "/builds/slave/test"] 20:14:55 INFO - --app=APP Application being installed. [default: firefox] 20:14:55 INFO - mkdir: /builds/slave/test/build/application 20:14:55 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'] 20:14:55 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 20:15:11 INFO - Reading from file tmpfile_stdout 20:15:11 INFO - Output received: 20:15:11 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:11 INFO - Running post-action listener: _resource_record_post_action 20:15:11 INFO - ##### 20:15:11 INFO - ##### Finished install step (success) 20:15:11 INFO - ##### 20:15:11 INFO - ##### 20:15:11 INFO - ##### Running run-tests step. 20:15:11 INFO - ##### 20:15:11 INFO - Running pre-action listener: _resource_record_pre_action 20:15:11 INFO - Running main action method: run_tests 20:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:11 INFO - Python 2.7.3 20:15:11 INFO - Return code: 0 20:15:11 INFO - grabbing minidump binary from tooltool 20:15:11 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')]} 20:15:11 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 0x1877570>, '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 0x1878470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1878900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:11 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 20:15:11 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 20:15:11 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 20:15:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:12 INFO - Return code: 0 20:15:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:15:12 INFO - Using env: {'DISPLAY': ':0', 20:15:12 INFO - 'HOME': '/home/cltbld', 20:15:12 INFO - 'LANG': 'en_US.UTF-8', 20:15:12 INFO - 'LANGUAGE': 'en_US:en', 20:15:12 INFO - 'LOGNAME': 'cltbld', 20:15:12 INFO - 'MAIL': '/var/mail/cltbld', 20:15:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:12 INFO - 'MOZ_NO_REMOTE': '1', 20:15:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:12 INFO - 'NO_EM_RESTART': '1', 20:15:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:12 INFO - 'PWD': '/builds/slave/test', 20:15:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:12 INFO - 'SHELL': '/bin/bash', 20:15:12 INFO - 'SHLVL': '1', 20:15:12 INFO - 'TERM': 'linux', 20:15:12 INFO - 'TMOUT': '86400', 20:15:12 INFO - 'USER': 'cltbld', 20:15:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154', 20:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:12 INFO - '_': '/tools/buildbot/bin/python'} 20:15:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:15:12 INFO - mozversion application_buildid: 20160706184624 20:15:12 INFO - mozversion application_changeset: 091b06284ffed4de98e00de2895e45195c3e70b3 20:15:12 INFO - mozversion application_display_name: Nightly 20:15:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:12 INFO - mozversion application_name: Firefox 20:15:12 INFO - mozversion application_remotingname: firefox 20:15:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:15:12 INFO - mozversion application_vendor: Mozilla 20:15:12 INFO - mozversion application_version: 50.0a1 20:15:12 INFO - mozversion platform_buildid: 20160706184624 20:15:12 INFO - mozversion platform_changeset: 091b06284ffed4de98e00de2895e45195c3e70b3 20:15:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:15:12 INFO - mozversion platform_version: 50.0a1 20:15:12 INFO - using testdate: 1467861312 20:15:12 INFO - actual date: 1467861312 20:15:12 INFO - starting webserver on 'localhost:43125' 20:15:12 INFO - SUITE-START | Running 2 tests 20:15:12 INFO - TEST-START | dromaeo_css 20:15:12 INFO - operating with platform_type : linux_ 20:15:12 INFO - Initialising browser for dromaeo_css test... 20:15:12 INFO - TEST-INFO | started process 15565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRjuEnD/profile http://localhost:43125/getInfo.html) 20:15:17 INFO - PROCESS | 15565 | __metrics Screen width/height:1600/1200 20:15:17 INFO - PROCESS | 15565 | colorDepth:24 20:15:17 INFO - PROCESS | 15565 | Browser inner width/height: 1024/697 20:15:17 INFO - PROCESS | 15565 | __metrics 20:15:18 ERROR - PROCESS | 15565 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 20:15:19 INFO - TEST-INFO | 15565: exit 0 20:15:19 INFO - Browser initialized. 20:15:19 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:19 INFO - TEST-INFO | started process 15685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRjuEnD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:31 INFO - PROCESS | 15685 | RSS: Main: 168660992 20:15:31 INFO - PROCESS | 15685 | 20:16:20 INFO - PROCESS | 15685 | 1467861380927 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] 20:18:33 INFO - PROCESS | 15685 | Cycle 1(1): loaded http://localhost:43125/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43125/tests/dromaeo/cssquery-ext.html) 20:18:34 INFO - PROCESS | 15685 | RSS: Main: 171167744 20:18:34 INFO - PROCESS | 15685 | 20:21:37 INFO - PROCESS | 15685 | Cycle 1(1): loaded http://localhost:43125/tests/dromaeo/cssquery-ext.html (next: http://localhost:43125/tests/dromaeo/cssquery-jquery.html) 20:21:37 INFO - PROCESS | 15685 | RSS: Main: 168103936 20:21:37 INFO - PROCESS | 15685 | 20:24:39 INFO - PROCESS | 15685 | Cycle 1(1): loaded http://localhost:43125/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43125/tests/dromaeo/cssquery-mootools.html) 20:24:40 INFO - PROCESS | 15685 | RSS: Main: 171577344 20:24:40 INFO - PROCESS | 15685 | 20:27:42 INFO - PROCESS | 15685 | Cycle 1(1): loaded http://localhost:43125/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43125/tests/dromaeo/cssquery-prototype.html) 20:27:42 INFO - PROCESS | 15685 | RSS: Main: 166961152 20:27:42 INFO - PROCESS | 15685 | 20:30:45 INFO - PROCESS | 15685 | Cycle 1(1): loaded http://localhost:43125/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43125/tests/dromaeo/cssquery-yui.html) 20:30:46 INFO - PROCESS | 15685 | RSS: Main: 169033728 20:30:46 INFO - PROCESS | 15685 | 20:33:48 INFO - PROCESS | 15685 | Cycle 1(1): loaded http://localhost:43125/tests/dromaeo/cssquery-yui.html (next: http://localhost:43125/tests/dromaeo/cssquery-dojo.html) 20:33:49 INFO - PROCESS | 15685 | RSS: Main: 170041344 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | __start_tp_report 20:33:49 INFO - PROCESS | 15685 | _x_x_mozilla_page_load 20:33:49 INFO - PROCESS | 15685 | _x_x_mozilla_page_load_details 20:33:49 INFO - PROCESS | 15685 | |i|pagename|runs| 20:33:49 INFO - PROCESS | 15685 | |0;dojo.html;2686.113582517769;2710.8509032003244;2723.700392956775;2742.2184677366954;2749.7937654675893;4895.461499235082;4945.530174633404;4951.851444456667;4955.925661115077;5022.096022715909;4808.086463571919;4896.363472748538;4926.842192084866;4934.5312195341385;4980.228064649976;4457.665675074374;4507.211238033347;4595.172868883599;4613.6078433333205;4629.768511574424;240.58529892253497;4376.5623437656295;4459.554044595547;4502.392177056105;4526.434195725535;4488.23699971004;4493;4494.797734101973;4511.526289739563;4519.548045195487;4527.705699129546;4529.6376289896725;4535.387722657432;4539.296409056601;4591.334256532818;4488.147252022105;4495.550444955511;4496.505384407713;4523.615492683093;4531.864044078683;4628.861134165981;4845.854624361275;4922.876928076791;4928.383952005999;4932.679375840559;5294.57643388528;5307.548858347045;5308.283381743454;5335.893282134374;5383.623146379755;5167.870803229912;5331.840044798662;5338.652987555835;5352.357717073937;5362.865928351784;4856.587190088882;4857.4171099467585;4873.658843880965;4887.242477416006;4901.313816065754;5342.54588359986;5349.798346843423;5353.57171426285;5359.812406565751;5407.324084489439;5045.167547354718;5175.792968281226;5198.428172900978;5224.50367215114;5232.110541208004;5312.150055991023;5312.1766126250495;5320.148776195868;5330.813421530228;5392.838214853561;5231.738413079331;5241.947580524222;5256.395514515803;5266.052110620049;5317.308749862493;5052.823151189691;5137.486251374833;5181.870453238699;5230.92153617696;5234.345706786652;4375.387445757597;4386.385905973167;4389.692721509464;4396.60430561251;4453.799579018952;3865.40086286626;3884.1066554692015;3909.667678247324;3915.5497117831246;3929.2141571685206;4474.552544745565;4513.480949690762;4520.570545798144;4520.909581808345;4549.385832912581;5266.368035835648;5281.20781882713;5311.814086507031;5320.920186197211;5368.677879327252;4520.773961301922;4552.476465206478;4554.817807287672;4563.315502674559;4571.040081582905;4595.425571803457;4709.034647897173;4736.905261894812;4746.976265118721;4755.595774359218;4985.800567977313;5002.899942001212;5021.372328458942;5028.157085333131;5046.34397528319;5184.066867963803;5331.200319952039;5335.893282134413;5341.813036543703;5353.518183363516;4917.409910810726;4948.356713627206;4990.775415106256;5024.748762561931;5062.974685126551;5158;5158.123119069692;5162.019216348882;5165.767540460613;5175.327207463006;5221.034108689752;5242.868928276671;5261.815836445706;5263.2631431600375;5285.418603953485;4939.629527785359;5070.847874563769;5107.233914912793;5136.229565565195;5139.871503212449;5109.540141387293;5113.181890897438;5117.462666419972;5124.359455068116;5183.0670479314085;4867.683600565952;4876.341693871282;5002.049610573979;5047.268146118866;5049.520295571915;5131.076406246912;5176.637635365489;5189.506996835295;5192.428832828461;5201.271821944855;5035.967626636604;5044.798208071636;5046.369203849519;5054.4692807254705;5062.873428164326 20:33:49 INFO - PROCESS | 15685 | |1;ext.html;563.7688547695444;570.3611954610836;582.2401765695765;610.5420934299276;619.721125493528;33332;34181.48727769082;37551.248975020484;37624.81187594065;37677.05807354821;36816.26367472649;37673.24653506928;37674.81162594183;37849.621503784954;37881.24237515255;7448.888266675991;7555.357794587467;7628.199039100898;7636.465447418683;7646.808829779272;7616.238376162395;7769.95105660737;7798.25916537928;7804.29761321481;7811.101723301807;7759.185285544993;7793.376529877596;7793.844123117534;7846.960765196194;7849.254320839511;7759.573223472707;7764.262395072459;7794.922050779476;7816.609169541557;7816.8827467588035;7653.770386888402;7763.961180194119;7764.223577642247;7768.57272849993;7792.181820908836;25279.747202528106;25414.237572872844;25478.10826621078;25488;25493.235202943943;2390.34265576966;2601.3626661467874;2900.1444573850554;2960.037987654021;3130.060981705479;28285.57571636427;28784.856075719486;29098.27254318659;29100.12699619015;29926.55110173349;3382.2051817822794;3387.6104248011547;3477.5826900772067;3500.6674365935196;3504.5093686883856;231834;232921;233177;233988.9999999983;234183;31785.364292714017;32846.17884552905;32846.17884552905;32914.50628240578;33048.173795655304;31427.52858707121;32108.19729506781;32179.678203218136;32227.35545289081;32300.19249518781;13676.111052781538;13814.516491922734;13926.512572060132;13941.930290348484;13957.79063314051;11591;11628.069754419626;11674.824877626843;11733.706657333465;11746.76506469883;7863.410244231705;7870.370370370357;7879.724209652634;7921.960390198127;7975.202479751978;3076.200187951149;3112.937741245162;3124.219444694224;3151.432742106397;3157.4790159623863;897.6005677473462;928.3501548915651;951.5717926932908;994.3834822410007;1002.8194924913586;28302.85848570744;28379.432411351656;29267.707322926497;29501.852490737838;30090.398192036475;927.6660402255183;950.4819873169139;965.5992763003416;983.8179936711731;1022.5091955861079;14937.327820248114;15200.315985780666;15377;15489.612759681098;15826.208689565476;365629;365681;373627;373787;374310;50097;50361.74819125881;50555.494445055076;50670.74664626653;50750.238746418836;1202.8436303280694;1204.4700331853956;1212.078820096733;1223.8225457308818;1235.857876344214;26954.730452696007;28570.571441428812;28836.567451488663;28963.565546517242;29135.271618209714;37926.43110353402;37945.62054379421;38099.80950095232;38206.61793382031;38309.808450957564;340356;340488;342674;343275;346674;24705.50588988246;25065;26052;26151.215463536126;27754.722452775215;42199;42834.357484637134;43498.565014350716;43652.56347436485;43706;36285.09287267734;37001;37282.25435491329;37793.433098504094;37976.81011594924;37353.81323093367;37608.81195594114;37718.43422348612;37928.810355948044;38388.80805595954;31877.20306992251;36722.26555468929;36765.897023089354;37071.44392834056;37754.62245377511;32696.34607307793;33790.3241935155;33996.66003339935;34292.314153717285;34313.48529772006;24616.18449140386;25557.616635750106;26309.60535592006;26438.339041524116;26701.599476008265 20:33:49 INFO - PROCESS | 15685 | |2;jquery.html;370.2871971454949;370.60160327647776;375.85153864223633;383.33300057899265;386.4319450407899;16575.585610359747;17641.029743364124;17933.193006314716;18281.908590457064;18343.17455714493;15946.84053159468;16149;16253.18734063298;16256.18719064048;16478.83521164791;5126.794928202868;5269.235960785683;5304.336957880265;5306;5306.151015837467;3763.811809409532;5192.792288308463;5869.2369991901;6201;6212.9068063979075;6184.196054512907;6200.16297799798;6214.285357183914;6215.409536094086;6238.844028899269;5069.746512674352;5359.919601205966;5366.221897824833;5430.864228394283;5450.3732070811575;5190.195519694454;5216.58267338612;5281.63028587999;5295.602829787743;5303.284056652341;11738.706532336675;12099.576514822027;12103.93948030263;20072.096755645885;20409;1832.4044685477272;1856.5173055005662;1902.8382587479941;1995.720599116125;2461.2616215135386;9024.684136055272;9105.453672779655;10003.24975626831;10390.53242604077;13622.93188534051;1711.8801683882134;1724.1637805664243;1727.9395221167324;1778.7065134252832;1787.7229029500447;62424.68787656078;62971;63449.68275158595;69389;76983.61508192479;9871.654492092743;10182.2181118304;10481.475926203659;10590.629327973484;10874;13846.584602461942;14286.499972500913;14460.566183014527;14477.927610362092;14582.562523124323;7244;7321.524100933422;7561.848763024819;7657.272559106876;7864.29221370068;7452.06849143857;7628.351590114791;7640.541567505968;7697.384209263358;7912.0505539335645;4070.939539711329;4154.106867023544;4478.081993191453;4538.364628951949;4547.909041819211;1751.9649607007789;1832.8647126097947;1837.6784062788959;1846.9630607387776;1871.0831692470592;830.1781236575747;878.9868151977726;901.9594118264694;918.7381596245039;966.8888077870994;17162.914185429243;17320.480385588453;17446.825531744773;17570.121493925253;17688.380906668204;864.6930339729431;868.0841711993907;871.6992637540038;882.911708829112;919.1406035356963;9194.448333099901;9505.144536991704;9785.168260697921;9851.704448866545;10055.29612927088;370770;374632;380716;381424;382381;79768;79884.60057699675;81008.18991810124;81969.59015204886;82007.58996204981;835.5028757888924;835.5195762436623;844.5988155626028;855.5251835231506;856.7900864288289;15390.461333853262;15497;15513.534593962198;15597.376104955674;15898;36720;37143.6285637151;37939.430908536946;38442.42336364901;38878.22243555057;49438;50880.74559627178;51209.743951280005;52434.47565524296;52440.213396799845;7322.597257150908;7493.550386976799;7550.509216900884;7600.2779735925;7711.6915323388685;11287.322760634388;11919.52321907114;11980.28118312904;12247.816282755588;12331.876681233072;9830.262730295113;9900.950495247478;10328.328658637165;10409.375437473776;10481.633142839964;10316.638917637847;10377.16982641402;10571.885622875301;10647.201459890694;10661.573537058432;10167.7458063549;10183.847242291224;10361.222908281758;10572.629957951434;10749.62376316825;7697.6151192441275;7720.150783413707;7744.535327880345;7904.723334683258;7945.364370850202;10125.088742013255;10188.694339169837;10397.948010259901;10433.165346772392;11093.833592496281 20:33:49 INFO - PROCESS | 15685 | |3;mootools.html;1371.2252577293825;1400.1319182107095;1506.3597970862381;1704.3438276263635;1736.1579633877575;7073.115860517435;7709.460337776358;7855.371570274378;8283.213094755996;8301.709440169596;7903.525788452697;8081.191880811931;8095.311898488636;8202.179782021794;8225.424220304581;2232.408411770882;2250.403643034589;2266.3767463947383;2269.7049383580193;2273.6589511573316;2241.540484200735;2252.9098836046537;2275.101334972685;2277.601419751545;2281.4068342231058;2218.5562887422498;2225.721784776903;2230.475838178035;2234.2850287907877;2278.3278932714807;2184.9563008739815;2196.934091977243;2197.48359135603;2200.0539767899795;2211.635080211763;2170.641844095738;2171.1098449635574;2175.8368122390884;2178.4662757624483;2178.9891050544807;8162.591870406456;8222.753317400488;8246.793830154294;8251.587420629005;8259.050209225896;4640.443146822369;4674.649401294882;4756.904861902743;4758.785854636515;4763.642726795504;2773.251222170023;2872.5547540131315;2902.6661933877663;2909.3599408130176;2921.24047747585;853.7609469348592;878.9077146899612;890.1676932068536;893.9553022348856;903.1420150856712;11081.27971681838;11093.335999600125;11104.833427498594;11128.221024528286;11199.104071674246;4145.316022856256;4217.894552636148;4354.303311470213;4387.912241755147;4394.494633117169;9463.763405914908;9481.051894810602;9532.332736708364;9566.091221334102;9596.23230141587;4741.857744267678;4751.073540659539;4769.618430525549;4778.761061946889;4786.473487916326;3795.658390744846;4102.384642303618;4269.658427325807;4269.7224680395675;4287.292596721506;3686.1337585667347;3717.070732316921;3783.432485127198;3828.4448754930936;3847.942280865789;1182.846229990113;1195.2410219510673;1196.8623608284984;1197.8502687164105;1226.178460431513;656.9638669873203;678.25053316086;853.1042405474227;867.7396780965685;877.591919757316;5223.712695801692;5494.423085575957;5554.972225138848;5627.71861406928;5688.715564221772;867.7873920889423;874.5670892908051;876.460976499461;907.832051070554;907.9364444488822;3539.292141571696;3823.445600387928;3937.6062393760394;3945.861894833667;4072.5927407259037;9992.15066719337;10138.341007834468;10189.592416303265;10201.693949181536;10241;9202.723918282461;9603.423794572209;10076.193904487624;10095.192384609214;10099.192064634812;7266.92733072673;7335.669894854637;7375.852482950311;7407.2592740725495;7427.7771666850085;5476;5692.658440493584;5693.146028095819;5753.884922301447;5806;9185.173334399937;9300;9405.153536181502;9419.811603768023;9458.101480359355;9306.255499559884;9455.716328510156;9493.810123797624;9574.377665451724;9586.856197156909;6846.965765171341;6978.860422791414;7038.2961703829205;7048.083749112788;7087.574745515286;7722.7297044603165;7844.803879903048;7858;7889.13219545861;7894.328982036591;6968.686409111703;7024.121984751906;7198.100237470317;7262.128544574685;7298.124225093023;6806.217285012287;6925.445964322741;6978.895316570154;7061;7155.856882862209;6565.540412171294;6672.966635166793;6698.899516507354;6715.4627629790475;6759.898601521079;4604.286335617984;4626.352310676575;4636.350910872548;4650.511696271843;4706.929396058993;4597.35637010812;4641.071785642817;4667.439907211156;4701.106789709944;4748.406449193851 20:33:49 INFO - PROCESS | 15685 | |4;prototype.html;298.1859523500843;303.8389653483653;308.3124632070482;310.78711082908194;311.962564492261;5027.472115427882;5085.313482679837;5120.846374608758;5131.563817075553;5134.2812006319145;5043.798248070082;5052.898942021157;5057.190849464087;5069.188929771238;5085.720285384303;3749.343864823659;3875.457435958968;3946.940795888064;3968.127012057357;3991.1618560102415;3946.506686664167;3962.128331767021;3978.781167035812;3996.5403978542404;4000.1799631075705;3956.329477602621;3966.504186976628;3967.8809635710977;3972.304846651839;3979.4229836673667;3672.265546890633;3881.9223615527812;3889.7082718796205;3972.781497017663;3977.6817854571564;3334.433146365124;3361.9831900840586;3362.7982321060813;3368.8989330319882;3376.4935259710996;4924.6060315175055;4924.630652701026;4936.629752768521;4941.209406494943;4942.357493525855;4282.400463935051;4410.514843367227;4440.844570440019;4443.289073748217;4454.688171827974;5249.186376111708;5275.736213189363;5279.099524171295;5319.281896943901;5324.440933701944;3651.379265524867;3663.5970043295215;3680.6319368062977;3687.3362794696945;3688.2807852468777;5423.023855706011;5555.361133469622;5566.693831839248;5590.301212348457;5594.328680558359;3739.476473293741;3754.9249015019545;3770.1140232045445;3771.698763926441;3782.6406491383823;3803.2773772983046;3814.798338523356;3817.0457385653585;3817.408301713239;3823.5602905665646;4380.014496738208;4387.056782791715;4396.318570621559;4399.142167277414;4403.832984259174;5043.5712964398435;5262.842114736564;5272.551833094153;5294;5294.955400644645;1329.955984552122;1339.270097796703;1340.7050448901225;1346.1855577375743;1352.2157148853642;836.7322456813882;844.687465637718;848.1645579104577;859.9226069653761;882.9028806831243;4604.217283061887;4605.65457590682;4618.745968971672;4638.2115040443205;4662.53374662531;5383.246345511553;5387.757550910218;5418.729063546807;5425.430329815313;5429.728513574306;4439.578240067189;4602.826279298757;4608.354830323758;4619.815207391734;4629.976850115728;2950.5131653276967;2953.8375389353364;2957.9704202958123;2958.778091643135;2984.65676447207;5189.974050129801;5203.583713302926;5212.696825793551;5217;5218.243354713622;5385.865353366119;5652.18043383707;5657.924994251079;5658.886822263614;5706.828795136153;5174;5178.508041736029;5191.039657663345;5196.583588631304;5227.163653815372;5488.4785945335125;5500.22996780459;5514.255575497417;5519.641223320471;5524.779008839601;5228.346456692913;5374;5380.488853558905;5382.246485491956;5416.21464887597;5169.457206993362;5178.922316165336;5212.687238765686;5217.165253559412;5232.3982741985155;3797.6012518686243;3828.5214348206473;3830.94253586202;3837.846486140523;3844.1927195289304;5363.463653634605;5482.643628164156;5490.972545137249;5495.422980586981;5503.614746967834;5285.920711189258;5296.576273898002;5301.284326615858;5310.336207974004;5315.202719592092;5057.443681194992;5269.552088072557;5303.939212157661;5313.123334649739;5313.309269794902;5188.948110518846;5195.68825870449;5218.765155568084;5230.450802665665;5233.842984710464;5046.243063540352;5149.356330458692;5282.154855223146;5292.655977361459;5307.6465501296925;5093.80295630534;5124.897502050013;5126.718030508208;5130.384353877409;5157.974210128926 20:33:49 INFO - PROCESS | 15685 | |5;yui.html;623.4171050068187;695.6591270277565;723.5116296499862;732.8790749526322;733.7211859493392;12962.092653514246;13913.373898174581;14037.578872633812;14042.087264327824;14076.4369425223;12371;12914;13045.478180872777;13057.477700891954;13091.214527128379;614.2475467552257;764.4381379685926;764.4954330142107;789.5973053742604;794.1026639896909;794.2534018023068;794.4518282385136;800.015980344177;804.047204063184;804.5534728225832;843.6878355008655;844.4806444036903;844.8817165596821;844.923956843884;846.3018010141627;822.8107535266893;830.9903467287245;833.1959658929102;836.2724429746099;839.6431516605448;604.8911195984721;613.4295105551835;613.6379536073694;615.4645458451131;616.8488720263564;13330.333483325794;13487;13499.595012149652;13529.864701352959;13551.59345219645;13538.187708737409;13569.321533923265;13684.93157534216;13746.793798092936;13802;10525.9473702631;10591.894081059245;10605.151587872951;10668.093212076983;10668.94665526675;3331;3357.345317663057;3384.4923261510726;3400.302937897725;3496.9825150874085;62677;63019.68490157566;64880.3511964879;65391;65638.67180664066;9744.269179811543;9951.154151897024;10160.847587286196;10221.211288024566;10394.948025259977;19948.401547953585;20164.29424970119;20389;20421.591568168555;20426.89786551058;7368.521046131984;7381.077365329334;7443.367313778282;7626.084869815547;7673.194314596887;3689.3359195345097;3838.961610383916;3846.9038274043373;3861.9806900965314;3870.1679138985255;2878.309205790595;2992.5361568956846;2994.670586235556;3013.186439661279;3025.6217972753407;521.1583292981807;523.5079025715814;535.7722967738696;540.106124364178;541.4287926237778;503.69526436505384;511.7671459485925;539.940606533281;545.4817922973191;579.5045236322967;8081.4747041442115;8102.06826214981;8205.835883282301;8276.627551760184;8329;452.53841082096733;584.4593750780512;594.5629961977943;597.5518361229078;598.937111603284;3584.56702594972;3872;3948.368261078214;3965.088029753173;3984.8007599619905;89255.55372223098;89281;91323.543382284;92414;94041.52979235197;80024.59987700025;80042.19957800464;80303.59848200838;82083.5895820517;82098;44905.77547112243;67411;68304.65847670729;69203.65398172977;69415.65292173506;8764.474131552128;8877.37858349935;9157.679481218125;9185.816283674423;9379.81240375175;30550;36867.63132368749;37600.62399375971;37789.4331585032;42283;40556.59443405528;46665.76667116643;50263;50943.490565093874;52668.736656316476;10235.641752538626;10402.375857448576;10502.947485262524;10566.207534435101;10722.142228621535;12952.028597855011;13120.60638180856;13426.395812188279;13483.460661573426;13818.632324070102;11651.941740291584;11988.520459181535;12304.692382690504;12685;12794.296313702836;12114.273143611412;12374.81437778416;12697.111202215756;12753.234805911305;13529.526466573623;11922.240619202264;12114.575989840665;12530;12550.43523041447;12718.809217861924;9885.357451765612;9914.20686345105;9922.107010369102;10075.899241007495;10258.384496930208;9722.854157187789;9770.267229957924;9922.710047693754;9941;10071.395716257048 20:33:49 INFO - PROCESS | 15685 | __end_tp_report 20:33:49 INFO - PROCESS | 15685 | __start_cc_report 20:33:49 INFO - PROCESS | 15685 | _x_x_mozilla_cycle_collect,388 20:33:49 INFO - PROCESS | 15685 | __end_cc_report 20:33:49 INFO - PROCESS | 15685 | __startTimestamp1467862429154__endTimestamp 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | ------- Summary: start ------- 20:33:49 INFO - PROCESS | 15685 | Number of tests: 6 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | [#0] dojo.html Cycles:165 Average:4833.70 Median:5002.90 stddev:630.71 (12.6%) stddev-sans-first:609.73 20:33:49 INFO - PROCESS | 15685 | Values: 2686.1 2710.9 2723.7 2742.2 2749.8 4895.5 4945.5 4951.9 4955.9 5022.1 4808.1 4896.4 4926.8 4934.5 4980.2 4457.7 4507.2 4595.2 4613.6 4629.8 240.6 4376.6 4459.6 4502.4 4526.4 4488.2 4493.0 4494.8 4511.5 4519.5 4527.7 4529.6 4535.4 4539.3 4591.3 4488.1 4495.6 4496.5 4523.6 4531.9 4628.9 4845.9 4922.9 4928.4 4932.7 5294.6 5307.5 5308.3 5335.9 5383.6 5167.9 5331.8 5338.7 5352.4 5362.9 4856.6 4857.4 4873.7 4887.2 4901.3 5342.5 5349.8 5353.6 5359.8 5407.3 5045.2 5175.8 5198.4 5224.5 5232.1 5312.2 5312.2 5320.1 5330.8 5392.8 5231.7 5241.9 5256.4 5266.1 5317.3 5052.8 5137.5 5181.9 5230.9 5234.3 4375.4 4386.4 4389.7 4396.6 4453.8 3865.4 3884.1 3909.7 3915.5 3929.2 4474.6 4513.5 4520.6 4520.9 4549.4 5266.4 5281.2 5311.8 5320.9 5368.7 4520.8 4552.5 4554.8 4563.3 4571.0 4595.4 4709.0 4736.9 4747.0 4755.6 4985.8 5002.9 5021.4 5028.2 5046.3 5184.1 5331.2 5335.9 5341.8 5353.5 4917.4 4948.4 4990.8 5024.7 5063.0 5158.0 5158.1 5162.0 5165.8 5175.3 5221.0 5242.9 5261.8 5263.3 5285.4 4939.6 5070.8 5107.2 5136.2 5139.9 5109.5 5113.2 5117.5 5124.4 5183.1 4867.7 4876.3 5002.0 5047.3 5049.5 5131.1 5176.6 5189.5 5192.4 5201.3 5036.0 5044.8 5046.4 5054.5 5062.9 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | [#1] ext.html Cycles:180 Average:45170.43 Median:344974.50 stddev:84752.40 (24.6%) stddev-sans-first:84923.98 20:33:49 INFO - PROCESS | 15685 | Values: 563.8 570.4 582.2 610.5 619.7 33332.0 34181.5 37551.2 37624.8 37677.1 36816.3 37673.2 37674.8 37849.6 37881.2 7448.9 7555.4 7628.2 7636.5 7646.8 7616.2 7770.0 7798.3 7804.3 7811.1 7759.2 7793.4 7793.8 7847.0 7849.3 7759.6 7764.3 7794.9 7816.6 7816.9 7653.8 7764.0 7764.2 7768.6 7792.2 25279.7 25414.2 25478.1 25488.0 25493.2 2390.3 2601.4 2900.1 2960.0 3130.1 28285.6 28784.9 29098.3 29100.1 29926.6 3382.2 3387.6 3477.6 3500.7 3504.5 231834.0 232921.0 233177.0 233989.0 234183.0 31785.4 32846.2 32846.2 32914.5 33048.2 31427.5 32108.2 32179.7 32227.4 32300.2 13676.1 13814.5 13926.5 13941.9 13957.8 11591.0 11628.1 11674.8 11733.7 11746.8 7863.4 7870.4 7879.7 7922.0 7975.2 3076.2 3112.9 3124.2 3151.4 3157.5 897.6 928.4 951.6 994.4 1002.8 28302.9 28379.4 29267.7 29501.9 30090.4 927.7 950.5 965.6 983.8 1022.5 14937.3 15200.3 15377.0 15489.6 15826.2 365629.0 365681.0 373627.0 373787.0 374310.0 50097.0 50361.7 50555.5 50670.7 50750.2 1202.8 1204.5 1212.1 1223.8 1235.9 26954.7 28570.6 28836.6 28963.6 29135.3 37926.4 37945.6 38099.8 38206.6 38309.8 340356.0 340488.0 342674.0 343275.0 346674.0 24705.5 25065.0 26052.0 26151.2 27754.7 42199.0 42834.4 43498.6 43652.6 43706.0 36285.1 37001.0 37282.3 37793.4 37976.8 37353.8 37608.8 37718.4 37928.8 38388.8 31877.2 36722.3 36765.9 37071.4 37754.6 32696.3 33790.3 33996.7 34292.3 34313.5 24616.2 25557.6 26309.6 26438.3 26701.6 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | [#2] jquery.html Cycles:180 Average:24074.44 Median:19632.33 stddev:62547.01 (318.6%) stddev-sans-first:62697.14 20:33:49 INFO - PROCESS | 15685 | Values: 370.3 370.6 375.9 383.3 386.4 16575.6 17641.0 17933.2 18281.9 18343.2 15946.8 16149.0 16253.2 16256.2 16478.8 5126.8 5269.2 5304.3 5306.0 5306.2 3763.8 5192.8 5869.2 6201.0 6212.9 6184.2 6200.2 6214.3 6215.4 6238.8 5069.7 5359.9 5366.2 5430.9 5450.4 5190.2 5216.6 5281.6 5295.6 5303.3 11738.7 12099.6 12103.9 20072.1 20409.0 1832.4 1856.5 1902.8 1995.7 2461.3 9024.7 9105.5 10003.2 10390.5 13622.9 1711.9 1724.2 1727.9 1778.7 1787.7 62424.7 62971.0 63449.7 69389.0 76983.6 9871.7 10182.2 10481.5 10590.6 10874.0 13846.6 14286.5 14460.6 14477.9 14582.6 7244.0 7321.5 7561.8 7657.3 7864.3 7452.1 7628.4 7640.5 7697.4 7912.1 4070.9 4154.1 4478.1 4538.4 4547.9 1752.0 1832.9 1837.7 1847.0 1871.1 830.2 879.0 902.0 918.7 966.9 17162.9 17320.5 17446.8 17570.1 17688.4 864.7 868.1 871.7 882.9 919.1 9194.4 9505.1 9785.2 9851.7 10055.3 370770.0 374632.0 380716.0 381424.0 382381.0 79768.0 79884.6 81008.2 81969.6 82007.6 835.5 835.5 844.6 855.5 856.8 15390.5 15497.0 15513.5 15597.4 15898.0 36720.0 37143.6 37939.4 38442.4 38878.2 49438.0 50880.7 51209.7 52434.5 52440.2 7322.6 7493.6 7550.5 7600.3 7711.7 11287.3 11919.5 11980.3 12247.8 12331.9 9830.3 9901.0 10328.3 10409.4 10481.6 10316.6 10377.2 10571.9 10647.2 10661.6 10167.7 10183.8 10361.2 10572.6 10749.6 7697.6 7720.2 7744.5 7904.7 7945.4 10125.1 10188.7 10397.9 10433.2 11093.8 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | [#3] mootools.html Cycles:180 Average:5334.65 Median:4782.62 stddev:3020.43 (63.2%) stddev-sans-first:3014.21 20:33:49 INFO - PROCESS | 15685 | Values: 1371.2 1400.1 1506.4 1704.3 1736.2 7073.1 7709.5 7855.4 8283.2 8301.7 7903.5 8081.2 8095.3 8202.2 8225.4 2232.4 2250.4 2266.4 2269.7 2273.7 2241.5 2252.9 2275.1 2277.6 2281.4 2218.6 2225.7 2230.5 2234.3 2278.3 2185.0 2196.9 2197.5 2200.1 2211.6 2170.6 2171.1 2175.8 2178.5 2179.0 8162.6 8222.8 8246.8 8251.6 8259.1 4640.4 4674.6 4756.9 4758.8 4763.6 2773.3 2872.6 2902.7 2909.4 2921.2 853.8 878.9 890.2 894.0 903.1 11081.3 11093.3 11104.8 11128.2 11199.1 4145.3 4217.9 4354.3 4387.9 4394.5 9463.8 9481.1 9532.3 9566.1 9596.2 4741.9 4751.1 4769.6 4778.8 4786.5 3795.7 4102.4 4269.7 4269.7 4287.3 3686.1 3717.1 3783.4 3828.4 3847.9 1182.8 1195.2 1196.9 1197.9 1226.2 657.0 678.3 853.1 867.7 877.6 5223.7 5494.4 5555.0 5627.7 5688.7 867.8 874.6 876.5 907.8 907.9 3539.3 3823.4 3937.6 3945.9 4072.6 9992.2 10138.3 10189.6 10201.7 10241.0 9202.7 9603.4 10076.2 10095.2 10099.2 7266.9 7335.7 7375.9 7407.3 7427.8 5476.0 5692.7 5693.1 5753.9 5806.0 9185.2 9300.0 9405.2 9419.8 9458.1 9306.3 9455.7 9493.8 9574.4 9586.9 6847.0 6978.9 7038.3 7048.1 7087.6 7722.7 7844.8 7858.0 7889.1 7894.3 6968.7 7024.1 7198.1 7262.1 7298.1 6806.2 6925.4 6978.9 7061.0 7155.9 6565.5 6673.0 6698.9 6715.5 6759.9 4604.3 4626.4 4636.4 4650.5 4706.9 4597.4 4641.1 4667.4 4701.1 4748.4 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | [#4] prototype.html Cycles:180 Average:4385.39 Median:5057.32 stddev:1290.07 (25.5%) stddev-sans-first:1256.69 20:33:49 INFO - PROCESS | 15685 | Values: 298.2 303.8 308.3 310.8 312.0 5027.5 5085.3 5120.8 5131.6 5134.3 5043.8 5052.9 5057.2 5069.2 5085.7 3749.3 3875.5 3946.9 3968.1 3991.2 3946.5 3962.1 3978.8 3996.5 4000.2 3956.3 3966.5 3967.9 3972.3 3979.4 3672.3 3881.9 3889.7 3972.8 3977.7 3334.4 3362.0 3362.8 3368.9 3376.5 4924.6 4924.6 4936.6 4941.2 4942.4 4282.4 4410.5 4440.8 4443.3 4454.7 5249.2 5275.7 5279.1 5319.3 5324.4 3651.4 3663.6 3680.6 3687.3 3688.3 5423.0 5555.4 5566.7 5590.3 5594.3 3739.5 3754.9 3770.1 3771.7 3782.6 3803.3 3814.8 3817.0 3817.4 3823.6 4380.0 4387.1 4396.3 4399.1 4403.8 5043.6 5262.8 5272.6 5294.0 5295.0 1330.0 1339.3 1340.7 1346.2 1352.2 836.7 844.7 848.2 859.9 882.9 4604.2 4605.7 4618.7 4638.2 4662.5 5383.2 5387.8 5418.7 5425.4 5429.7 4439.6 4602.8 4608.4 4619.8 4630.0 2950.5 2953.8 2958.0 2958.8 2984.7 5190.0 5203.6 5212.7 5217.0 5218.2 5385.9 5652.2 5657.9 5658.9 5706.8 5174.0 5178.5 5191.0 5196.6 5227.2 5488.5 5500.2 5514.3 5519.6 5524.8 5228.3 5374.0 5380.5 5382.2 5416.2 5169.5 5178.9 5212.7 5217.2 5232.4 3797.6 3828.5 3830.9 3837.8 3844.2 5363.5 5482.6 5491.0 5495.4 5503.6 5285.9 5296.6 5301.3 5310.3 5315.2 5057.4 5269.6 5303.9 5313.1 5313.3 5188.9 5195.7 5218.8 5230.5 5233.8 5046.2 5149.4 5282.2 5292.7 5307.6 5093.8 5124.9 5126.7 5130.4 5158.0 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - PROCESS | 15685 | [#5] yui.html Cycles:180 Average:16847.36 Median:25383.35 stddev:23193.91 (91.4%) stddev-sans-first:23226.98 20:33:49 INFO - PROCESS | 15685 | Values: 623.4 695.7 723.5 732.9 733.7 12962.1 13913.4 14037.6 14042.1 14076.4 12371.0 12914.0 13045.5 13057.5 13091.2 614.2 764.4 764.5 789.6 794.1 794.3 794.5 800.0 804.0 804.6 843.7 844.5 844.9 844.9 846.3 822.8 831.0 833.2 836.3 839.6 604.9 613.4 613.6 615.5 616.8 13330.3 13487.0 13499.6 13529.9 13551.6 13538.2 13569.3 13684.9 13746.8 13802.0 10525.9 10591.9 10605.2 10668.1 10668.9 3331.0 3357.3 3384.5 3400.3 3497.0 62677.0 63019.7 64880.4 65391.0 65638.7 9744.3 9951.2 10160.8 10221.2 10394.9 19948.4 20164.3 20389.0 20421.6 20426.9 7368.5 7381.1 7443.4 7626.1 7673.2 3689.3 3839.0 3846.9 3862.0 3870.2 2878.3 2992.5 2994.7 3013.2 3025.6 521.2 523.5 535.8 540.1 541.4 503.7 511.8 539.9 545.5 579.5 8081.5 8102.1 8205.8 8276.6 8329.0 452.5 584.5 594.6 597.6 598.9 3584.6 3872.0 3948.4 3965.1 3984.8 89255.6 89281.0 91323.5 92414.0 94041.5 80024.6 80042.2 80303.6 82083.6 82098.0 44905.8 67411.0 68304.7 69203.7 69415.7 8764.5 8877.4 9157.7 9185.8 9379.8 30550.0 36867.6 37600.6 37789.4 42283.0 40556.6 46665.8 50263.0 50943.5 52668.7 10235.6 10402.4 10502.9 10566.2 10722.1 12952.0 13120.6 13426.4 13483.5 13818.6 11651.9 11988.5 12304.7 12685.0 12794.3 12114.3 12374.8 12697.1 12753.2 13529.5 11922.2 12114.6 12530.0 12550.4 12718.8 9885.4 9914.2 9922.1 10075.9 10258.4 9722.9 9770.3 9922.7 9941.0 10071.4 20:33:49 INFO - PROCESS | 15685 | -------- Summary: end -------- 20:33:49 INFO - PROCESS | 15685 | 20:33:49 INFO - TEST-INFO | 15685: exit 0 20:33:49 INFO - TEST-OK | dromaeo_css | took 1117705ms 20:33:49 INFO - TEST-START | kraken 20:33:49 INFO - operating with platform_type : linux_ 20:33:49 INFO - Initialising browser for kraken test... 20:33:49 INFO - TEST-INFO | started process 15931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfGVfKJ/profile http://localhost:43125/getInfo.html) 20:33:55 INFO - PROCESS | 15931 | __metrics Screen width/height:1600/1200 20:33:55 INFO - PROCESS | 15931 | colorDepth:24 20:33:55 INFO - PROCESS | 15931 | Browser inner width/height: 1024/697 20:33:55 INFO - PROCESS | 15931 | __metrics 20:33:55 ERROR - PROCESS | 15931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 20:33:56 INFO - TEST-INFO | 15931: exit 0 20:33:56 INFO - Browser initialized. 20:33:56 INFO - Running cycle 1/1 for kraken test... 20:33:56 INFO - TEST-INFO | started process 16050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfGVfKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:08 INFO - PROCESS | 16050 | RSS: Main: 168812544 20:34:08 INFO - PROCESS | 16050 | 20:34:11 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43125/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:12 INFO - PROCESS | 16050 | RSS: Main: 174239744 20:34:12 INFO - PROCESS | 16050 | 20:34:15 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43125/tests/kraken/driver.html?testName=audio-dft) 20:34:15 INFO - PROCESS | 16050 | RSS: Main: 173527040 20:34:15 INFO - PROCESS | 16050 | 20:34:18 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43125/tests/kraken/driver.html?testName=audio-fft) 20:34:19 INFO - PROCESS | 16050 | RSS: Main: 168595456 20:34:19 INFO - PROCESS | 16050 | 20:34:21 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43125/tests/kraken/driver.html?testName=audio-oscillator) 20:34:22 INFO - PROCESS | 16050 | RSS: Main: 169054208 20:34:22 INFO - PROCESS | 16050 | 20:34:24 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43125/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:24 INFO - PROCESS | 16050 | RSS: Main: 169484288 20:34:25 INFO - PROCESS | 16050 | 20:34:28 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43125/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:28 INFO - PROCESS | 16050 | RSS: Main: 169857024 20:34:28 INFO - PROCESS | 16050 | 20:34:32 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43125/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:33 INFO - PROCESS | 16050 | RSS: Main: 167452672 20:34:33 INFO - PROCESS | 16050 | 20:34:36 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43125/tests/kraken/driver.html?testName=json-parse-financial) 20:34:36 INFO - PROCESS | 16050 | RSS: Main: 168312832 20:34:36 INFO - PROCESS | 16050 | 20:34:38 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43125/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:39 INFO - PROCESS | 16050 | RSS: Main: 168583168 20:34:39 INFO - PROCESS | 16050 | 20:34:40 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:34:41 INFO - PROCESS | 16050 | RSS: Main: 168726528 20:34:41 INFO - PROCESS | 16050 | 20:34:43 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:34:44 INFO - PROCESS | 16050 | RSS: Main: 169287680 20:34:44 INFO - PROCESS | 16050 | 20:34:47 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:34:47 INFO - PROCESS | 16050 | RSS: Main: 169684992 20:34:47 INFO - PROCESS | 16050 | 20:34:50 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:34:51 INFO - PROCESS | 16050 | RSS: Main: 169066496 20:34:51 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | Cycle 1(1): loaded http://localhost:43125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43125/tests/kraken/driver.html?testName=ai-astar) 20:34:53 INFO - PROCESS | 16050 | RSS: Main: 170360832 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | __start_tp_report 20:34:53 INFO - PROCESS | 16050 | _x_x_mozilla_page_load 20:34:53 INFO - PROCESS | 16050 | _x_x_mozilla_page_load_details 20:34:53 INFO - PROCESS | 16050 | |i|pagename|runs| 20:34:53 INFO - PROCESS | 16050 | |0;ai-astar;106;113;108;115;114;115;119;114;111;113 20:34:53 INFO - PROCESS | 16050 | |1;audio-beat-detection;145;121;149;179;126;149;147;126;187;125 20:34:53 INFO - PROCESS | 16050 | |2;audio-dft;163;165;164;166;167;167;162;164;164;163 20:34:53 INFO - PROCESS | 16050 | |3;audio-fft;77;77;76;154;76;76;76;76;171;78 20:34:53 INFO - PROCESS | 16050 | |4;audio-oscillator;86;85;143;87;86;86;135;86;86;130 20:34:53 INFO - PROCESS | 16050 | |5;imaging-gaussian-blur;118;119;118;119;117;118;118;118;119;117 20:34:53 INFO - PROCESS | 16050 | |6;imaging-darkroom;147;148;148;150;148;149;148;149;149;147 20:34:53 INFO - PROCESS | 16050 | |7;imaging-desaturate;96;96;96;95;95;95;96;95;95;95 20:34:53 INFO - PROCESS | 16050 | |8;json-parse-financial;66;65;65;65;66;66;66;66;72;71 20:34:53 INFO - PROCESS | 16050 | |9;json-stringify-tinderbox;64;66;64;65;65;66;64;65;65;65 20:34:53 INFO - PROCESS | 16050 | |10;stanford-crypto-aes;80;79;78;88;79;80;85;80;89;78 20:34:53 INFO - PROCESS | 16050 | |11;stanford-crypto-ccm;145;145;127;140;139;133;128;132;177;142 20:34:53 INFO - PROCESS | 16050 | |12;stanford-crypto-pbkdf2;171;170;167;166;172;168;167;169;165;166 20:34:53 INFO - PROCESS | 16050 | |13;stanford-crypto-sha256-iterative;69;67;70;67;67;68;67;67;72;65 20:34:53 INFO - PROCESS | 16050 | __end_tp_report 20:34:53 INFO - PROCESS | 16050 | __start_cc_report 20:34:53 INFO - PROCESS | 16050 | _x_x_mozilla_cycle_collect,974 20:34:53 INFO - PROCESS | 16050 | __end_cc_report 20:34:53 INFO - PROCESS | 16050 | __startTimestamp1467862493433__endTimestamp 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | ------- Summary: start ------- 20:34:53 INFO - PROCESS | 16050 | Number of tests: 14 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.71 (3.3%) stddev-sans-first:3.00 20:34:53 INFO - PROCESS | 16050 | Values: 106.0 113.0 108.0 115.0 114.0 115.0 119.0 114.0 111.0 113.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:148.00 stddev:22.74 (15.4%) stddev-sans-first:24.11 20:34:53 INFO - PROCESS | 16050 | Values: 145.0 121.0 149.0 179.0 126.0 149.0 147.0 126.0 187.0 125.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:1.72 (1.0%) stddev-sans-first:1.73 20:34:53 INFO - PROCESS | 16050 | Values: 163.0 165.0 164.0 166.0 167.0 167.0 162.0 164.0 164.0 163.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:36.49 (48.0%) stddev-sans-first:38.20 20:34:53 INFO - PROCESS | 16050 | Values: 77.0 77.0 76.0 154.0 76.0 76.0 76.0 76.0 171.0 78.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:86.00 stddev:24.35 (28.3%) stddev-sans-first:25.22 20:34:53 INFO - PROCESS | 16050 | Values: 86.0 85.0 143.0 87.0 86.0 86.0 135.0 86.0 86.0 130.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 20:34:53 INFO - PROCESS | 16050 | Values: 118.0 119.0 118.0 119.0 117.0 118.0 118.0 118.0 119.0 117.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 20:34:53 INFO - PROCESS | 16050 | Values: 147.0 148.0 148.0 150.0 148.0 149.0 148.0 149.0 149.0 147.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:34:53 INFO - PROCESS | 16050 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:66.00 stddev:2.53 (3.8%) stddev-sans-first:2.67 20:34:53 INFO - PROCESS | 16050 | Values: 66.0 65.0 65.0 65.0 66.0 66.0 66.0 66.0 72.0 71.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 20:34:53 INFO - PROCESS | 16050 | Values: 64.0 66.0 64.0 65.0 65.0 66.0 64.0 65.0 65.0 65.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.00 stddev:4.14 (5.2%) stddev-sans-first:4.35 20:34:53 INFO - PROCESS | 16050 | Values: 80.0 79.0 78.0 88.0 79.0 80.0 85.0 80.0 89.0 78.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:141.00 stddev:14.31 (10.2%) stddev-sans-first:15.10 20:34:53 INFO - PROCESS | 16050 | Values: 145.0 145.0 127.0 140.0 139.0 133.0 128.0 132.0 177.0 142.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.50 stddev:2.33 (1.4%) stddev-sans-first:2.22 20:34:53 INFO - PROCESS | 16050 | Values: 171.0 170.0 167.0 166.0 172.0 168.0 167.0 169.0 165.0 166.0 20:34:53 INFO - PROCESS | 16050 | 20:34:53 INFO - PROCESS | 16050 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:1.97 (2.9%) stddev-sans-first:2.05 20:34:53 INFO - PROCESS | 16050 | Values: 69.0 67.0 70.0 67.0 67.0 68.0 67.0 67.0 72.0 65.0 20:34:53 INFO - PROCESS | 16050 | -------- Summary: end -------- 20:34:53 INFO - PROCESS | 16050 | 20:34:54 INFO - TEST-INFO | 16050: exit 0 20:34:54 INFO - TEST-OK | kraken | took 64526ms 20:34:54 INFO - SUITE-END | took 1182s 20:34:54 INFO - Completed test suite (00:19:42) 20:34:54 INFO - javascript benchmark 20:34:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6436.075276600897, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.113582517769, 2710.8509032003244, 2723.700392956775, 2742.2184677366954, 2749.7937654675893, 4895.461499235082, 4945.530174633404, 4951.851444456667, 4955.925661115077, 5022.096022715909, 4808.086463571919, 4896.363472748538, 4926.842192084866, 4934.5312195341385, 4980.228064649976, 4457.665675074374, 4507.211238033347, 4595.172868883599, 4613.6078433333205, 4629.768511574424, 240.58529892253497, 4376.5623437656295, 4459.554044595547, 4502.392177056105, 4526.434195725535, 4488.23699971004, 4493.0, 4494.797734101973, 4511.526289739563, 4519.548045195487, 4527.705699129546, 4529.6376289896725, 4535.387722657432, 4539.296409056601, 4591.334256532818, 4488.147252022105, 4495.550444955511, 4496.505384407713, 4523.615492683093, 4531.864044078683, 4628.861134165981, 4845.854624361275, 4922.876928076791, 4928.383952005999, 4932.679375840559, 5294.57643388528, 5307.548858347045, 5308.283381743454, 5335.893282134374, 5383.623146379755, 5167.870803229912, 5331.840044798662, 5338.652987555835, 5352.357717073937, 5362.865928351784, 4856.587190088882, 4857.4171099467585, 4873.658843880965, 4887.242477416006, 4901.313816065754, 5342.54588359986, 5349.798346843423, 5353.57171426285, 5359.812406565751, 5407.324084489439, 5045.167547354718, 5175.792968281226, 5198.428172900978, 5224.50367215114, 5232.110541208004, 5312.150055991023, 5312.1766126250495, 5320.148776195868, 5330.813421530228, 5392.838214853561, 5231.738413079331, 5241.947580524222, 5256.395514515803, 5266.052110620049, 5317.308749862493, 5052.823151189691, 5137.486251374833, 5181.870453238699, 5230.92153617696, 5234.345706786652, 4375.387445757597, 4386.385905973167, 4389.692721509464, 4396.60430561251, 4453.799579018952, 3865.40086286626, 3884.1066554692015, 3909.667678247324, 3915.5497117831246, 3929.2141571685206, 4474.552544745565, 4513.480949690762, 4520.570545798144, 4520.909581808345, 4549.385832912581, 5266.368035835648, 5281.20781882713, 5311.814086507031, 5320.920186197211, 5368.677879327252, 4520.773961301922, 4552.476465206478, 4554.817807287672, 4563.315502674559, 4571.040081582905, 4595.425571803457, 4709.034647897173, 4736.905261894812, 4746.976265118721, 4755.595774359218, 4985.800567977313, 5002.899942001212, 5021.372328458942, 5028.157085333131, 5046.34397528319, 5184.066867963803, 5331.200319952039, 5335.893282134413, 5341.813036543703, 5353.518183363516, 4917.409910810726, 4948.356713627206, 4990.775415106256, 5024.748762561931, 5062.974685126551, 5158.0, 5158.123119069692, 5162.019216348882, 5165.767540460613, 5175.327207463006, 5221.034108689752, 5242.868928276671, 5261.815836445706, 5263.2631431600375, 5285.418603953485, 4939.629527785359, 5070.847874563769, 5107.233914912793, 5136.229565565195, 5139.871503212449, 5109.540141387293, 5113.181890897438, 5117.462666419972, 5124.359455068116, 5183.0670479314085, 4867.683600565952, 4876.341693871282, 5002.049610573979, 5047.268146118866, 5049.520295571915, 5131.076406246912, 5176.637635365489, 5189.506996835295, 5192.428832828461, 5201.271821944855, 5035.967626636604, 5044.798208071636, 5046.369203849519, 5054.4692807254705, 5062.873428164326], "value": 4794.969092069932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7688547695444, 570.3611954610836, 582.2401765695765, 610.5420934299276, 619.721125493528, 33332.0, 34181.48727769082, 37551.248975020484, 37624.81187594065, 37677.05807354821, 36816.26367472649, 37673.24653506928, 37674.81162594183, 37849.621503784954, 37881.24237515255, 7448.888266675991, 7555.357794587467, 7628.199039100898, 7636.465447418683, 7646.808829779272, 7616.238376162395, 7769.95105660737, 7798.25916537928, 7804.29761321481, 7811.101723301807, 7759.185285544993, 7793.376529877596, 7793.844123117534, 7846.960765196194, 7849.254320839511, 7759.573223472707, 7764.262395072459, 7794.922050779476, 7816.609169541557, 7816.8827467588035, 7653.770386888402, 7763.961180194119, 7764.223577642247, 7768.57272849993, 7792.181820908836, 25279.747202528106, 25414.237572872844, 25478.10826621078, 25488.0, 25493.235202943943, 2390.34265576966, 2601.3626661467874, 2900.1444573850554, 2960.037987654021, 3130.060981705479, 28285.57571636427, 28784.856075719486, 29098.27254318659, 29100.12699619015, 29926.55110173349, 3382.2051817822794, 3387.6104248011547, 3477.5826900772067, 3500.6674365935196, 3504.5093686883856, 231834.0, 232921.0, 233177.0, 233988.9999999983, 234183.0, 31785.364292714017, 32846.17884552905, 32846.17884552905, 32914.50628240578, 33048.173795655304, 31427.52858707121, 32108.19729506781, 32179.678203218136, 32227.35545289081, 32300.19249518781, 13676.111052781538, 13814.516491922734, 13926.512572060132, 13941.930290348484, 13957.79063314051, 11591.0, 11628.069754419626, 11674.824877626843, 11733.706657333465, 11746.76506469883, 7863.410244231705, 7870.370370370357, 7879.724209652634, 7921.960390198127, 7975.202479751978, 3076.200187951149, 3112.937741245162, 3124.219444694224, 3151.432742106397, 3157.4790159623863, 897.6005677473462, 928.3501548915651, 951.5717926932908, 994.3834822410007, 1002.8194924913586, 28302.85848570744, 28379.432411351656, 29267.707322926497, 29501.852490737838, 30090.398192036475, 927.6660402255183, 950.4819873169139, 965.5992763003416, 983.8179936711731, 1022.5091955861079, 14937.327820248114, 15200.315985780666, 15377.0, 15489.612759681098, 15826.208689565476, 365629.0, 365681.0, 373627.0, 373787.0, 374310.0, 50097.0, 50361.74819125881, 50555.494445055076, 50670.74664626653, 50750.238746418836, 1202.8436303280694, 1204.4700331853956, 1212.078820096733, 1223.8225457308818, 1235.857876344214, 26954.730452696007, 28570.571441428812, 28836.567451488663, 28963.565546517242, 29135.271618209714, 37926.43110353402, 37945.62054379421, 38099.80950095232, 38206.61793382031, 38309.808450957564, 340356.0, 340488.0, 342674.0, 343275.0, 346674.0, 24705.50588988246, 25065.0, 26052.0, 26151.215463536126, 27754.722452775215, 42199.0, 42834.357484637134, 43498.565014350716, 43652.56347436485, 43706.0, 36285.09287267734, 37001.0, 37282.25435491329, 37793.433098504094, 37976.81011594924, 37353.81323093367, 37608.81195594114, 37718.43422348612, 37928.810355948044, 38388.80805595954, 31877.20306992251, 36722.26555468929, 36765.897023089354, 37071.44392834056, 37754.62245377511, 32696.34607307793, 33790.3241935155, 33996.66003339935, 34292.314153717285, 34313.48529772006, 24616.18449140386, 25557.616635750106, 26309.60535592006, 26438.339041524116, 26701.599476008265], "value": 16086.568611608063, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2871971454949, 370.60160327647776, 375.85153864223633, 383.33300057899265, 386.4319450407899, 16575.585610359747, 17641.029743364124, 17933.193006314716, 18281.908590457064, 18343.17455714493, 15946.84053159468, 16149.0, 16253.18734063298, 16256.18719064048, 16478.83521164791, 5126.794928202868, 5269.235960785683, 5304.336957880265, 5306.0, 5306.151015837467, 3763.811809409532, 5192.792288308463, 5869.2369991901, 6201.0, 6212.9068063979075, 6184.196054512907, 6200.16297799798, 6214.285357183914, 6215.409536094086, 6238.844028899269, 5069.746512674352, 5359.919601205966, 5366.221897824833, 5430.864228394283, 5450.3732070811575, 5190.195519694454, 5216.58267338612, 5281.63028587999, 5295.602829787743, 5303.284056652341, 11738.706532336675, 12099.576514822027, 12103.93948030263, 20072.096755645885, 20409.0, 1832.4044685477272, 1856.5173055005662, 1902.8382587479941, 1995.720599116125, 2461.2616215135386, 9024.684136055272, 9105.453672779655, 10003.24975626831, 10390.53242604077, 13622.93188534051, 1711.8801683882134, 1724.1637805664243, 1727.9395221167324, 1778.7065134252832, 1787.7229029500447, 62424.68787656078, 62971.0, 63449.68275158595, 69389.0, 76983.61508192479, 9871.654492092743, 10182.2181118304, 10481.475926203659, 10590.629327973484, 10874.0, 13846.584602461942, 14286.499972500913, 14460.566183014527, 14477.927610362092, 14582.562523124323, 7244.0, 7321.524100933422, 7561.848763024819, 7657.272559106876, 7864.29221370068, 7452.06849143857, 7628.351590114791, 7640.541567505968, 7697.384209263358, 7912.0505539335645, 4070.939539711329, 4154.106867023544, 4478.081993191453, 4538.364628951949, 4547.909041819211, 1751.9649607007789, 1832.8647126097947, 1837.6784062788959, 1846.9630607387776, 1871.0831692470592, 830.1781236575747, 878.9868151977726, 901.9594118264694, 918.7381596245039, 966.8888077870994, 17162.914185429243, 17320.480385588453, 17446.825531744773, 17570.121493925253, 17688.380906668204, 864.6930339729431, 868.0841711993907, 871.6992637540038, 882.911708829112, 919.1406035356963, 9194.448333099901, 9505.144536991704, 9785.168260697921, 9851.704448866545, 10055.29612927088, 370770.0, 374632.0, 380716.0, 381424.0, 382381.0, 79768.0, 79884.60057699675, 81008.18991810124, 81969.59015204886, 82007.58996204981, 835.5028757888924, 835.5195762436623, 844.5988155626028, 855.5251835231506, 856.7900864288289, 15390.461333853262, 15497.0, 15513.534593962198, 15597.376104955674, 15898.0, 36720.0, 37143.6285637151, 37939.430908536946, 38442.42336364901, 38878.22243555057, 49438.0, 50880.74559627178, 51209.743951280005, 52434.47565524296, 52440.213396799845, 7322.597257150908, 7493.550386976799, 7550.509216900884, 7600.2779735925, 7711.6915323388685, 11287.322760634388, 11919.52321907114, 11980.28118312904, 12247.816282755588, 12331.876681233072, 9830.262730295113, 9900.950495247478, 10328.328658637165, 10409.375437473776, 10481.633142839964, 10316.638917637847, 10377.16982641402, 10571.885622875301, 10647.201459890694, 10661.573537058432, 10167.7458063549, 10183.847242291224, 10361.222908281758, 10572.629957951434, 10749.62376316825, 7697.6151192441275, 7720.150783413707, 7744.535327880345, 7904.723334683258, 7945.364370850202, 10125.088742013255, 10188.694339169837, 10397.948010259901, 10433.165346772392, 11093.833592496281], "value": 8296.242676348242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.2252577293825, 1400.1319182107095, 1506.3597970862381, 1704.3438276263635, 1736.1579633877575, 7073.115860517435, 7709.460337776358, 7855.371570274378, 8283.213094755996, 8301.709440169596, 7903.525788452697, 8081.191880811931, 8095.311898488636, 8202.179782021794, 8225.424220304581, 2232.408411770882, 2250.403643034589, 2266.3767463947383, 2269.7049383580193, 2273.6589511573316, 2241.540484200735, 2252.9098836046537, 2275.101334972685, 2277.601419751545, 2281.4068342231058, 2218.5562887422498, 2225.721784776903, 2230.475838178035, 2234.2850287907877, 2278.3278932714807, 2184.9563008739815, 2196.934091977243, 2197.48359135603, 2200.0539767899795, 2211.635080211763, 2170.641844095738, 2171.1098449635574, 2175.8368122390884, 2178.4662757624483, 2178.9891050544807, 8162.591870406456, 8222.753317400488, 8246.793830154294, 8251.587420629005, 8259.050209225896, 4640.443146822369, 4674.649401294882, 4756.904861902743, 4758.785854636515, 4763.642726795504, 2773.251222170023, 2872.5547540131315, 2902.6661933877663, 2909.3599408130176, 2921.24047747585, 853.7609469348592, 878.9077146899612, 890.1676932068536, 893.9553022348856, 903.1420150856712, 11081.27971681838, 11093.335999600125, 11104.833427498594, 11128.221024528286, 11199.104071674246, 4145.316022856256, 4217.894552636148, 4354.303311470213, 4387.912241755147, 4394.494633117169, 9463.763405914908, 9481.051894810602, 9532.332736708364, 9566.091221334102, 9596.23230141587, 4741.857744267678, 4751.073540659539, 4769.618430525549, 4778.761061946889, 4786.473487916326, 3795.658390744846, 4102.384642303618, 4269.658427325807, 4269.7224680395675, 4287.292596721506, 3686.1337585667347, 3717.070732316921, 3783.432485127198, 3828.4448754930936, 3847.942280865789, 1182.846229990113, 1195.2410219510673, 1196.8623608284984, 1197.8502687164105, 1226.178460431513, 656.9638669873203, 678.25053316086, 853.1042405474227, 867.7396780965685, 877.591919757316, 5223.712695801692, 5494.423085575957, 5554.972225138848, 5627.71861406928, 5688.715564221772, 867.7873920889423, 874.5670892908051, 876.460976499461, 907.832051070554, 907.9364444488822, 3539.292141571696, 3823.445600387928, 3937.6062393760394, 3945.861894833667, 4072.5927407259037, 9992.15066719337, 10138.341007834468, 10189.592416303265, 10201.693949181536, 10241.0, 9202.723918282461, 9603.423794572209, 10076.193904487624, 10095.192384609214, 10099.192064634812, 7266.92733072673, 7335.669894854637, 7375.852482950311, 7407.2592740725495, 7427.7771666850085, 5476.0, 5692.658440493584, 5693.146028095819, 5753.884922301447, 5806.0, 9185.173334399937, 9300.0, 9405.153536181502, 9419.811603768023, 9458.101480359355, 9306.255499559884, 9455.716328510156, 9493.810123797624, 9574.377665451724, 9586.856197156909, 6846.965765171341, 6978.860422791414, 7038.2961703829205, 7048.083749112788, 7087.574745515286, 7722.7297044603165, 7844.803879903048, 7858.0, 7889.13219545861, 7894.328982036591, 6968.686409111703, 7024.121984751906, 7198.100237470317, 7262.128544574685, 7298.124225093023, 6806.217285012287, 6925.445964322741, 6978.895316570154, 7061.0, 7155.856882862209, 6565.540412171294, 6672.966635166793, 6698.899516507354, 6715.4627629790475, 6759.898601521079, 4604.286335617984, 4626.352310676575, 4636.350910872548, 4650.511696271843, 4706.929396058993, 4597.35637010812, 4641.071785642817, 4667.439907211156, 4701.106789709944, 4748.406449193851], "value": 4264.636419993378, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.1859523500843, 303.8389653483653, 308.3124632070482, 310.78711082908194, 311.962564492261, 5027.472115427882, 5085.313482679837, 5120.846374608758, 5131.563817075553, 5134.2812006319145, 5043.798248070082, 5052.898942021157, 5057.190849464087, 5069.188929771238, 5085.720285384303, 3749.343864823659, 3875.457435958968, 3946.940795888064, 3968.127012057357, 3991.1618560102415, 3946.506686664167, 3962.128331767021, 3978.781167035812, 3996.5403978542404, 4000.1799631075705, 3956.329477602621, 3966.504186976628, 3967.8809635710977, 3972.304846651839, 3979.4229836673667, 3672.265546890633, 3881.9223615527812, 3889.7082718796205, 3972.781497017663, 3977.6817854571564, 3334.433146365124, 3361.9831900840586, 3362.7982321060813, 3368.8989330319882, 3376.4935259710996, 4924.6060315175055, 4924.630652701026, 4936.629752768521, 4941.209406494943, 4942.357493525855, 4282.400463935051, 4410.514843367227, 4440.844570440019, 4443.289073748217, 4454.688171827974, 5249.186376111708, 5275.736213189363, 5279.099524171295, 5319.281896943901, 5324.440933701944, 3651.379265524867, 3663.5970043295215, 3680.6319368062977, 3687.3362794696945, 3688.2807852468777, 5423.023855706011, 5555.361133469622, 5566.693831839248, 5590.301212348457, 5594.328680558359, 3739.476473293741, 3754.9249015019545, 3770.1140232045445, 3771.698763926441, 3782.6406491383823, 3803.2773772983046, 3814.798338523356, 3817.0457385653585, 3817.408301713239, 3823.5602905665646, 4380.014496738208, 4387.056782791715, 4396.318570621559, 4399.142167277414, 4403.832984259174, 5043.5712964398435, 5262.842114736564, 5272.551833094153, 5294.0, 5294.955400644645, 1329.955984552122, 1339.270097796703, 1340.7050448901225, 1346.1855577375743, 1352.2157148853642, 836.7322456813882, 844.687465637718, 848.1645579104577, 859.9226069653761, 882.9028806831243, 4604.217283061887, 4605.65457590682, 4618.745968971672, 4638.2115040443205, 4662.53374662531, 5383.246345511553, 5387.757550910218, 5418.729063546807, 5425.430329815313, 5429.728513574306, 4439.578240067189, 4602.826279298757, 4608.354830323758, 4619.815207391734, 4629.976850115728, 2950.5131653276967, 2953.8375389353364, 2957.9704202958123, 2958.778091643135, 2984.65676447207, 5189.974050129801, 5203.583713302926, 5212.696825793551, 5217.0, 5218.243354713622, 5385.865353366119, 5652.18043383707, 5657.924994251079, 5658.886822263614, 5706.828795136153, 5174.0, 5178.508041736029, 5191.039657663345, 5196.583588631304, 5227.163653815372, 5488.4785945335125, 5500.22996780459, 5514.255575497417, 5519.641223320471, 5524.779008839601, 5228.346456692913, 5374.0, 5380.488853558905, 5382.246485491956, 5416.21464887597, 5169.457206993362, 5178.922316165336, 5212.687238765686, 5217.165253559412, 5232.3982741985155, 3797.6012518686243, 3828.5214348206473, 3830.94253586202, 3837.846486140523, 3844.1927195289304, 5363.463653634605, 5482.643628164156, 5490.972545137249, 5495.422980586981, 5503.614746967834, 5285.920711189258, 5296.576273898002, 5301.284326615858, 5310.336207974004, 5315.202719592092, 5057.443681194992, 5269.552088072557, 5303.939212157661, 5313.123334649739, 5313.309269794902, 5188.948110518846, 5195.68825870449, 5218.765155568084, 5230.450802665665, 5233.842984710464, 5046.243063540352, 5149.356330458692, 5282.154855223146, 5292.655977361459, 5307.6465501296925, 5093.80295630534, 5124.897502050013, 5126.718030508208, 5130.384353877409, 5157.974210128926], "value": 3971.0747478133885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.4171050068187, 695.6591270277565, 723.5116296499862, 732.8790749526322, 733.7211859493392, 12962.092653514246, 13913.373898174581, 14037.578872633812, 14042.087264327824, 14076.4369425223, 12371.0, 12914.0, 13045.478180872777, 13057.477700891954, 13091.214527128379, 614.2475467552257, 764.4381379685926, 764.4954330142107, 789.5973053742604, 794.1026639896909, 794.2534018023068, 794.4518282385136, 800.015980344177, 804.047204063184, 804.5534728225832, 843.6878355008655, 844.4806444036903, 844.8817165596821, 844.923956843884, 846.3018010141627, 822.8107535266893, 830.9903467287245, 833.1959658929102, 836.2724429746099, 839.6431516605448, 604.8911195984721, 613.4295105551835, 613.6379536073694, 615.4645458451131, 616.8488720263564, 13330.333483325794, 13487.0, 13499.595012149652, 13529.864701352959, 13551.59345219645, 13538.187708737409, 13569.321533923265, 13684.93157534216, 13746.793798092936, 13802.0, 10525.9473702631, 10591.894081059245, 10605.151587872951, 10668.093212076983, 10668.94665526675, 3331.0, 3357.345317663057, 3384.4923261510726, 3400.302937897725, 3496.9825150874085, 62677.0, 63019.68490157566, 64880.3511964879, 65391.0, 65638.67180664066, 9744.269179811543, 9951.154151897024, 10160.847587286196, 10221.211288024566, 10394.948025259977, 19948.401547953585, 20164.29424970119, 20389.0, 20421.591568168555, 20426.89786551058, 7368.521046131984, 7381.077365329334, 7443.367313778282, 7626.084869815547, 7673.194314596887, 3689.3359195345097, 3838.961610383916, 3846.9038274043373, 3861.9806900965314, 3870.1679138985255, 2878.309205790595, 2992.5361568956846, 2994.670586235556, 3013.186439661279, 3025.6217972753407, 521.1583292981807, 523.5079025715814, 535.7722967738696, 540.106124364178, 541.4287926237778, 503.69526436505384, 511.7671459485925, 539.940606533281, 545.4817922973191, 579.5045236322967, 8081.4747041442115, 8102.06826214981, 8205.835883282301, 8276.627551760184, 8329.0, 452.53841082096733, 584.4593750780512, 594.5629961977943, 597.5518361229078, 598.937111603284, 3584.56702594972, 3872.0, 3948.368261078214, 3965.088029753173, 3984.8007599619905, 89255.55372223098, 89281.0, 91323.543382284, 92414.0, 94041.52979235197, 80024.59987700025, 80042.19957800464, 80303.59848200838, 82083.5895820517, 82098.0, 44905.77547112243, 67411.0, 68304.65847670729, 69203.65398172977, 69415.65292173506, 8764.474131552128, 8877.37858349935, 9157.679481218125, 9185.816283674423, 9379.81240375175, 30550.0, 36867.63132368749, 37600.62399375971, 37789.4331585032, 42283.0, 40556.59443405528, 46665.76667116643, 50263.0, 50943.490565093874, 52668.736656316476, 10235.641752538626, 10402.375857448576, 10502.947485262524, 10566.207534435101, 10722.142228621535, 12952.028597855011, 13120.60638180856, 13426.395812188279, 13483.460661573426, 13818.632324070102, 11651.941740291584, 11988.520459181535, 12304.692382690504, 12685.0, 12794.296313702836, 12114.273143611412, 12374.81437778416, 12697.111202215756, 12753.234805911305, 13529.526466573623, 11922.240619202264, 12114.575989840665, 12530.0, 12550.43523041447, 12718.809217861924, 9885.357451765612, 9914.20686345105, 9922.107010369102, 10075.899241007495, 10258.384496930208, 9722.854157187789, 9770.267229957924, 9922.710047693754, 9941.0, 10071.395716257048], "value": 6557.880205960376, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 108.0, 115.0, 114.0, 115.0, 119.0, 114.0, 111.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 149.0, 179.0, 126.0, 149.0, 147.0, 126.0, 187.0, 125.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 166.0, 167.0, 167.0, 162.0, 164.0, 164.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 154.0, 76.0, 76.0, 76.0, 76.0, 171.0, 78.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 143.0, 87.0, 86.0, 86.0, 135.0, 86.0, 86.0, 130.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 119.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 150.0, 148.0, 149.0, 148.0, 149.0, 149.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 72.0, 71.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 88.0, 79.0, 80.0, 85.0, 80.0, 89.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 127.0, 140.0, 139.0, 133.0, 128.0, 132.0, 177.0, 142.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 167.0, 166.0, 172.0, 168.0, 167.0, 169.0, 165.0, 166.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 67.0, 67.0, 68.0, 67.0, 67.0, 72.0, 65.0], "value": 67.9, "unit": "score"}]}]} 20:34:54 INFO - Return code: 0 20:34:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:34:54 ERROR - # TBPL SUCCESS # 20:34:54 INFO - Running post-action listener: _resource_record_post_action 20:34:54 INFO - ##### 20:34:54 INFO - ##### Finished run-tests step (success) 20:34:54 INFO - ##### 20:34:54 INFO - Running post-run listener: _resource_record_post_run 20:34:54 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557436928; Read time: 12; Write time: 566536 20:34:54 INFO - TinderboxPrint: CPU usage
13.3% 20:34:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:34:54 INFO - TinderboxPrint: I/O write bytes / time
557,436,928 / 566,536 20:34:54 INFO - TinderboxPrint: CPU idle
8,292.2 (86.7%) 20:34:54 INFO - TinderboxPrint: CPU user
1,217.2 (12.7%) 20:34:54 INFO - TinderboxPrint: Swap in / out
0 / 0 20:34:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258129920; Read time: 0; Write time: 324652 20:34:54 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 299307008; Read time: 0; Write time: 241884 20:34:55 INFO - Running post-run listener: _upload_blobber_files 20:34:55 INFO - Blob upload gear active. 20:34:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:34:55 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 20:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:34:55 INFO - (blobuploader) - INFO - Open directory for files ... 20:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:34:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:56 INFO - (blobuploader) - INFO - Done attempting. 20:34:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:34:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:59 INFO - (blobuploader) - INFO - Done attempting. 20:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:00 INFO - (blobuploader) - INFO - Done attempting. 20:35:00 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:00 INFO - Return code: 0 20:35:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/689d2aab94a435be343bac6450e069c0d231e517d846f29c19979299d35595a4669447692956e74470a7b8d7a4e530175477b1281e076bf0e5a752b0d1485c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d039665b8b832114ac8dff6f5a84a8d1533f9f0e7aecfe1161d1521fa18177661e3c159627305262cecf95770565cee5d9b32c3517bb6da0c4965490debd30e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67917c5c2c42d96b8c6e2a7d2c44d0724f38a85c5860639c94127d19fb7300083181d60e3480aebfacfb3764c5bf0a863cc097229632ca2edf11f8471e8cb4b7"} 20:35:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:00 INFO - Contents: 20:35:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/689d2aab94a435be343bac6450e069c0d231e517d846f29c19979299d35595a4669447692956e74470a7b8d7a4e530175477b1281e076bf0e5a752b0d1485c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d039665b8b832114ac8dff6f5a84a8d1533f9f0e7aecfe1161d1521fa18177661e3c159627305262cecf95770565cee5d9b32c3517bb6da0c4965490debd30e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67917c5c2c42d96b8c6e2a7d2c44d0724f38a85c5860639c94127d19fb7300083181d60e3480aebfacfb3764c5bf0a863cc097229632ca2edf11f8471e8cb4b7"} 20:35:00 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:00 INFO - Copying logs to upload dir... 20:35:00 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.677366 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-06 20:35:00.490659) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 20:35:00.494677) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/689d2aab94a435be343bac6450e069c0d231e517d846f29c19979299d35595a4669447692956e74470a7b8d7a4e530175477b1281e076bf0e5a752b0d1485c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d039665b8b832114ac8dff6f5a84a8d1533f9f0e7aecfe1161d1521fa18177661e3c159627305262cecf95770565cee5d9b32c3517bb6da0c4965490debd30e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67917c5c2c42d96b8c6e2a7d2c44d0724f38a85c5860639c94127d19fb7300083181d60e3480aebfacfb3764c5bf0a863cc097229632ca2edf11f8471e8cb4b7"} build_url:https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/Gx2VjeGLSAKI6nDV2KIOgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/689d2aab94a435be343bac6450e069c0d231e517d846f29c19979299d35595a4669447692956e74470a7b8d7a4e530175477b1281e076bf0e5a752b0d1485c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d039665b8b832114ac8dff6f5a84a8d1533f9f0e7aecfe1161d1521fa18177661e3c159627305262cecf95770565cee5d9b32c3517bb6da0c4965490debd30e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67917c5c2c42d96b8c6e2a7d2c44d0724f38a85c5860639c94127d19fb7300083181d60e3480aebfacfb3764c5bf0a863cc097229632ca2edf11f8471e8cb4b7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 20:35:00.523574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:35:00.524091) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467860741.145159-735830154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 20:35:00.608708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 20:35:00.609460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 20:35:00.610134) ========= ========= Total master_lag: 0.21 =========