builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1467659433.34 results: success (0) buildid: 20160704111823 builduid: 0a2fa04c122b424f8dd211416aa175ff revision: fdffe351484e4abbd32f686424ff840ae05f0992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.337597) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.338016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.338336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.396980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.397240) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 12:10:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 11.0M=0.001s 2016-07-04 12:10:33 (11.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.567337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.567612) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022246 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:33.617548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 12:10:33.617886) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fdffe351484e4abbd32f686424ff840ae05f0992 --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 fdffe351484e4abbd32f686424ff840ae05f0992 --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=9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 12:10:34,071 truncating revision to first 12 chars 2016-07-04 12:10:34,071 Setting DEBUG logging. 2016-07-04 12:10:34,071 attempt 1/10 2016-07-04 12:10:34,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fdffe351484e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 12:10:35,430 unpacking tar archive at: fx-team-fdffe351484e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.768677 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 12:10:35.400323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:35.400617) ========= script_repo_revision: fdffe351484e4abbd32f686424ff840ae05f0992 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:35.401037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:35.401315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 12:10:35.412359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-04 12:10:35.412624) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:10:35 INFO - MultiFileLogger online at 20160704 12:10:35 in /builds/slave/test 12:10:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 12:10:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:10:35 INFO - {'append_to_log': False, 12:10:35 INFO - 'base_work_dir': '/builds/slave/test', 12:10:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:10:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:10:35 INFO - 'branch': 'Fx-Team-Non-PGO', 12:10:35 INFO - 'buildbot_json_path': 'buildprops.json', 12:10:35 INFO - 'config_files': ('talos/linux_config.py',), 12:10:35 INFO - 'default_actions': ('clobber', 12:10:35 INFO - 'read-buildbot-config', 12:10:35 INFO - 'download-and-extract', 12:10:35 INFO - 'populate-webroot', 12:10:35 INFO - 'create-virtualenv', 12:10:35 INFO - 'install', 12:10:35 INFO - 'run-tests'), 12:10:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:10:35 INFO - 'download_minidump_stackwalk': True, 12:10:35 INFO - 'download_symbols': 'ondemand', 12:10:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:10:35 INFO - 'tooltool.py': '/tools/tooltool.py', 12:10:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:10:35 INFO - '/tools/misc-python/virtualenv.py')}, 12:10:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:10:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:10:35 INFO - 'installer_path': 'installer.exe', 12:10:35 INFO - 'log_level': 'info', 12:10:35 INFO - 'log_name': 'talos', 12:10:35 INFO - 'log_to_console': True, 12:10:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:10:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:10:35 INFO - 'opt_config_files': (), 12:10:35 INFO - 'pip_index': False, 12:10:35 INFO - 'sps_profile': False, 12:10:35 INFO - 'sps_profile_interval': 0, 12:10:35 INFO - 'suite': 'dromaeojs', 12:10:35 INFO - 'system_bits': '32', 12:10:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:10:35 INFO - 'title': 'talos-linux64-ix-022', 12:10:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:10:35 INFO - 'use_talos_json': True, 12:10:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:10:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:10:35 INFO - 'work_dir': 'build'} 12:10:35 INFO - ##### 12:10:35 INFO - ##### Running clobber step. 12:10:35 INFO - ##### 12:10:35 INFO - Running pre-action listener: _resource_record_pre_action 12:10:35 INFO - Running main action method: clobber 12:10:35 INFO - rmtree: /builds/slave/test/build 12:10:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:10:36 INFO - Running post-action listener: _resource_record_post_action 12:10:36 INFO - ##### 12:10:36 INFO - ##### Finished clobber step (success) 12:10:36 INFO - ##### 12:10:36 INFO - ##### 12:10:36 INFO - ##### Running read-buildbot-config step. 12:10:36 INFO - ##### 12:10:36 INFO - Running pre-action listener: _resource_record_pre_action 12:10:36 INFO - Running main action method: read_buildbot_config 12:10:36 INFO - Using buildbot properties: 12:10:36 INFO - { 12:10:36 INFO - "project": "", 12:10:36 INFO - "product": "firefox", 12:10:36 INFO - "script_repo_revision": "production", 12:10:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:10:36 INFO - "repository": "", 12:10:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:10:36 INFO - "buildid": "20160704111823", 12:10:36 INFO - "pgo_build": "False", 12:10:36 INFO - "basedir": "/builds/slave/test", 12:10:36 INFO - "buildnumber": 3128, 12:10:36 INFO - "slavename": "talos-linux64-ix-022", 12:10:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:10:36 INFO - "platform": "ubuntu64_hw", 12:10:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:10:36 INFO - "branch": "fx-team", 12:10:36 INFO - "repo_path": "integration/fx-team", 12:10:36 INFO - "revision": "fdffe351484e4abbd32f686424ff840ae05f0992", 12:10:36 INFO - "stage_platform": "linux64", 12:10:36 INFO - "builduid": "0a2fa04c122b424f8dd211416aa175ff", 12:10:36 INFO - "slavebuilddir": "test" 12:10:36 INFO - } 12:10:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:10:36 INFO - Running post-action listener: _resource_record_post_action 12:10:36 INFO - ##### 12:10:36 INFO - ##### Finished read-buildbot-config step (success) 12:10:36 INFO - ##### 12:10:36 INFO - ##### 12:10:36 INFO - ##### Running download-and-extract step. 12:10:36 INFO - ##### 12:10:36 INFO - Running pre-action listener: _resource_record_pre_action 12:10:36 INFO - Running main action method: download_and_extract 12:10:36 INFO - mkdir: /builds/slave/test/build/tests 12:10: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')]} 12:10:36 INFO - https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:42 INFO - Downloaded 1361 bytes. 12:10:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:10:42 INFO - Using the following test package requirements: 12:10:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:10:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:10:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:10:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'jsshell-linux-x86_64.zip'], 12:10:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:10:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:10:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:10:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:10:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:10:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:10:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:10:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:10:42 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')]} 12:10:42 INFO - https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:46 INFO - Downloaded 22709820 bytes. 12:10:46 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'] 12:10:46 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 12:10:47 INFO - Return code: 0 12:10:47 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 12:10: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')]} 12:10:47 INFO - https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:10:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:10:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:10:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:52 INFO - Downloaded 22709820 bytes. 12:10:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:10:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:10:54 INFO - Return code: 0 12:10: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')]} 12:10:54 INFO - https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:10:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:10:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:10:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:55 INFO - Downloaded 14403333 bytes. 12:10:55 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'] 12:10:55 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 12:10:55 INFO - Return code: 0 12:10: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')]} 12:10:55 INFO - https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:10:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:10:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:10:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RY4KsDZFTXefh5Y4qkONlA/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 12:10:56 INFO - Downloaded 56485362 bytes. 12:10:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:10:56 INFO - mkdir: /builds/slave/test/properties 12:10:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:10:56 INFO - Writing to file /builds/slave/test/properties/build_url 12:10:56 INFO - Contents: 12:10:56 INFO - build_url:https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:10:57 INFO - Running post-action listener: _resource_record_post_action 12:10:57 INFO - Running post-action listener: set_extra_try_arguments 12:10:57 INFO - ##### 12:10:57 INFO - ##### Finished download-and-extract step (success) 12:10:57 INFO - ##### 12:10:57 INFO - ##### 12:10:57 INFO - ##### Running populate-webroot step. 12:10:57 INFO - ##### 12:10:57 INFO - Running pre-action listener: _resource_record_pre_action 12:10:57 INFO - Running main action method: populate_webroot 12:10:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:10:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:10:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:10:57 INFO - '--tppagecycles', 12:10:57 INFO - '7'], 12:10:57 INFO - 'tests': ['tsvgm']}}, 12:10:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:10:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:10:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:10:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:10:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['damp', 'tps']}, 12:10:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'tests': ['damp', 'tps']}, 12:10:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['dromaeo_dom']}, 12:10:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:10:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['basic_compositor_video']}, 12:10:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:10:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['a11yr', 12:10:57 INFO - 'ts_paint', 12:10:57 INFO - 'tpaint', 12:10:57 INFO - 'sessionrestore', 12:10:57 INFO - 'sessionrestore_no_auto_restore', 12:10:57 INFO - 'tabpaint']}, 12:10:57 INFO - 'other-e10s': {'tests': ['a11yr', 12:10:57 INFO - 'ts_paint', 12:10:57 INFO - 'tpaint', 12:10:57 INFO - 'sessionrestore', 12:10:57 INFO - 'sessionrestore_no_auto_restore', 12:10:57 INFO - 'tabpaint']}, 12:10:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:10:57 INFO - 'ts_paint', 12:10:57 INFO - 'tpaint', 12:10:57 INFO - 'sessionrestore', 12:10:57 INFO - 'sessionrestore_no_auto_restore', 12:10:57 INFO - 'tabpaint']}, 12:10:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:10:57 INFO - 'ts_paint', 12:10:57 INFO - 'tpaint', 12:10:57 INFO - 'sessionrestore', 12:10:57 INFO - 'sessionrestore_no_auto_restore', 12:10:57 INFO - 'tabpaint']}, 12:10:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['a11yr', 12:10:57 INFO - 'ts_paint', 12:10:57 INFO - 'tpaint', 12:10:57 INFO - 'sessionrestore', 12:10:57 INFO - 'sessionrestore_no_auto_restore', 12:10:57 INFO - 'tabpaint']}, 12:10:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['a11yr', 12:10:57 INFO - 'ts_paint', 12:10:57 INFO - 'tpaint', 12:10:57 INFO - 'sessionrestore', 12:10:57 INFO - 'sessionrestore_no_auto_restore', 12:10:57 INFO - 'tabpaint']}, 12:10:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['tsvgx', 12:10:57 INFO - 'tsvgr_opacity', 12:10:57 INFO - 'tart', 12:10:57 INFO - 'tscrollx', 12:10:57 INFO - 'cart']}, 12:10:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:10:57 INFO - 'tsvgr_opacity', 12:10:57 INFO - 'tart', 12:10:57 INFO - 'tscrollx', 12:10:57 INFO - 'cart']}, 12:10:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'talos_options': ['--disable-e10s'], 12:10:57 INFO - 'tests': ['tp5o']}, 12:10:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'tests': ['tp5o']}, 12:10:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'talos_options': ['--disable-e10s', 12:10:57 INFO - '--xperf_path', 12:10:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:57 INFO - 'tests': ['tp5n']}, 12:10:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:57 INFO - 'talos_options': ['--xperf_path', 12:10:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:57 INFO - 'tests': ['tp5n']}}, 12:10:57 INFO - 'talos.zip': {'path': '', 12:10:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:10:57 INFO - Running post-action listener: _resource_record_post_action 12:10:57 INFO - ##### 12:10:57 INFO - ##### Finished populate-webroot step (success) 12:10:57 INFO - ##### 12:10:57 INFO - ##### 12:10:57 INFO - ##### Running create-virtualenv step. 12:10:57 INFO - ##### 12:10:57 INFO - Running pre-action listener: _resource_record_pre_action 12:10:57 INFO - Running main action method: create_virtualenv 12:10:57 INFO - Creating virtualenv /builds/slave/test/build/venv 12:10:57 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 12:10:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:10:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:10:57 INFO - Using real prefix '/usr' 12:10:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:10:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:11:00 INFO - Installing pip.................done. 12:11:00 INFO - Return code: 0 12:11:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:11:00 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')]} 12:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:00 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')]} 12:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:00 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:00 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 12:11:00 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 12:11:00 INFO - Using env: {'DISPLAY': ':0', 12:11:00 INFO - 'HOME': '/home/cltbld', 12:11:00 INFO - 'LANG': 'en_US.UTF-8', 12:11:00 INFO - 'LANGUAGE': 'en_US:en', 12:11:00 INFO - 'LOGNAME': 'cltbld', 12:11:00 INFO - 'MAIL': '/var/mail/cltbld', 12:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:00 INFO - 'MOZ_NO_REMOTE': '1', 12:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:00 INFO - 'NO_EM_RESTART': '1', 12:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:00 INFO - 'PWD': '/builds/slave/test', 12:11:00 INFO - 'SHELL': '/bin/bash', 12:11:00 INFO - 'SHLVL': '1', 12:11:00 INFO - 'TERM': 'linux', 12:11:00 INFO - 'TMOUT': '86400', 12:11:00 INFO - 'USER': 'cltbld', 12:11:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:00 INFO - '_': '/tools/buildbot/bin/python'} 12:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:00 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 12:11:00 INFO - Cleaning up... 12:11:00 INFO - Return code: 0 12:11:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:11:00 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')]} 12:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:00 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')]} 12:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:00 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:00 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 12:11:00 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 12:11:00 INFO - Using env: {'DISPLAY': ':0', 12:11:00 INFO - 'HOME': '/home/cltbld', 12:11:00 INFO - 'LANG': 'en_US.UTF-8', 12:11:00 INFO - 'LANGUAGE': 'en_US:en', 12:11:00 INFO - 'LOGNAME': 'cltbld', 12:11:00 INFO - 'MAIL': '/var/mail/cltbld', 12:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:00 INFO - 'MOZ_NO_REMOTE': '1', 12:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:00 INFO - 'NO_EM_RESTART': '1', 12:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:00 INFO - 'PWD': '/builds/slave/test', 12:11:00 INFO - 'SHELL': '/bin/bash', 12:11:00 INFO - 'SHLVL': '1', 12:11:00 INFO - 'TERM': 'linux', 12:11:00 INFO - 'TMOUT': '86400', 12:11:00 INFO - 'USER': 'cltbld', 12:11:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:00 INFO - '_': '/tools/buildbot/bin/python'} 12:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:00 INFO - Downloading/unpacking psutil>=3.1.1 12:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:11:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:11:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:11:02 INFO - Installing collected packages: psutil 12:11:02 INFO - Running setup.py install for psutil 12:11:02 INFO - building 'psutil._psutil_linux' extension 12:11:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:11:02 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 12:11:02 INFO - building 'psutil._psutil_posix' extension 12:11:02 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 12:11:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:11:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:11:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:11:03 INFO - Successfully installed psutil 12:11:03 INFO - Cleaning up... 12:11:03 INFO - Return code: 0 12:11:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:11:03 INFO - Using env: {'DISPLAY': ':0', 12:11:03 INFO - 'HOME': '/home/cltbld', 12:11:03 INFO - 'LANG': 'en_US.UTF-8', 12:11:03 INFO - 'LANGUAGE': 'en_US:en', 12:11:03 INFO - 'LOGNAME': 'cltbld', 12:11:03 INFO - 'MAIL': '/var/mail/cltbld', 12:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:03 INFO - 'MOZ_NO_REMOTE': '1', 12:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:03 INFO - 'NO_EM_RESTART': '1', 12:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:03 INFO - 'PWD': '/builds/slave/test', 12:11:03 INFO - 'SHELL': '/bin/bash', 12:11:03 INFO - 'SHLVL': '1', 12:11:03 INFO - 'TERM': 'linux', 12:11:03 INFO - 'TMOUT': '86400', 12:11:03 INFO - 'USER': 'cltbld', 12:11:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:03 INFO - '_': '/tools/buildbot/bin/python'} 12:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:11:05 INFO - Installing collected packages: mozsystemmonitor 12:11:05 INFO - Running setup.py install for mozsystemmonitor 12:11:05 INFO - Successfully installed mozsystemmonitor 12:11:05 INFO - Cleaning up... 12:11:05 INFO - Return code: 0 12:11:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:11:05 INFO - Using env: {'DISPLAY': ':0', 12:11:05 INFO - 'HOME': '/home/cltbld', 12:11:05 INFO - 'LANG': 'en_US.UTF-8', 12:11:05 INFO - 'LANGUAGE': 'en_US:en', 12:11:05 INFO - 'LOGNAME': 'cltbld', 12:11:05 INFO - 'MAIL': '/var/mail/cltbld', 12:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:05 INFO - 'MOZ_NO_REMOTE': '1', 12:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:05 INFO - 'NO_EM_RESTART': '1', 12:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:05 INFO - 'PWD': '/builds/slave/test', 12:11:05 INFO - 'SHELL': '/bin/bash', 12:11:05 INFO - 'SHLVL': '1', 12:11:05 INFO - 'TERM': 'linux', 12:11:05 INFO - 'TMOUT': '86400', 12:11:05 INFO - 'USER': 'cltbld', 12:11:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:05 INFO - '_': '/tools/buildbot/bin/python'} 12:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:05 INFO - Downloading/unpacking jsonschema==2.5.1 12:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:11:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:07 INFO - Downloading functools32-3.2.3-2.tar.gz 12:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:11:07 INFO - warning: no files found matching '*.txt' 12:11:07 INFO - no previously-included directories found matching 'build' 12:11:07 INFO - no previously-included directories found matching 'dist' 12:11:07 INFO - no previously-included directories found matching '.git*' 12:11:07 INFO - Installing collected packages: jsonschema, functools32 12:11:07 INFO - Running setup.py install for functools32 12:11:07 INFO - warning: no files found matching '*.txt' 12:11:07 INFO - no previously-included directories found matching 'build' 12:11:07 INFO - no previously-included directories found matching 'dist' 12:11:07 INFO - no previously-included directories found matching '.git*' 12:11:07 INFO - Successfully installed jsonschema functools32 12:11:07 INFO - Cleaning up... 12:11:08 INFO - Return code: 0 12:11:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:11:08 INFO - Using env: {'DISPLAY': ':0', 12:11:08 INFO - 'HOME': '/home/cltbld', 12:11:08 INFO - 'LANG': 'en_US.UTF-8', 12:11:08 INFO - 'LANGUAGE': 'en_US:en', 12:11:08 INFO - 'LOGNAME': 'cltbld', 12:11:08 INFO - 'MAIL': '/var/mail/cltbld', 12:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:08 INFO - 'MOZ_NO_REMOTE': '1', 12:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:08 INFO - 'NO_EM_RESTART': '1', 12:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:08 INFO - 'PWD': '/builds/slave/test', 12:11:08 INFO - 'SHELL': '/bin/bash', 12:11:08 INFO - 'SHLVL': '1', 12:11:08 INFO - 'TERM': 'linux', 12:11:08 INFO - 'TMOUT': '86400', 12:11:08 INFO - 'USER': 'cltbld', 12:11:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:08 INFO - '_': '/tools/buildbot/bin/python'} 12:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:08 INFO - Downloading/unpacking blobuploader==1.2.4 12:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:10 INFO - Downloading blobuploader-1.2.4.tar.gz 12:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:11:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:11:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:10 INFO - Downloading docopt-0.6.1.tar.gz 12:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:11:10 INFO - Installing collected packages: blobuploader, requests, docopt 12:11:10 INFO - Running setup.py install for blobuploader 12:11:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:11:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:11:10 INFO - Running setup.py install for requests 12:11:11 INFO - Running setup.py install for docopt 12:11:11 INFO - Successfully installed blobuploader requests docopt 12:11:11 INFO - Cleaning up... 12:11:11 INFO - Return code: 0 12:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11: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')]} 12:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11: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')]} 12:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:11 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:11 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 12:11:11 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 12:11:11 INFO - Using env: {'DISPLAY': ':0', 12:11:11 INFO - 'HOME': '/home/cltbld', 12:11:11 INFO - 'LANG': 'en_US.UTF-8', 12:11:11 INFO - 'LANGUAGE': 'en_US:en', 12:11:11 INFO - 'LOGNAME': 'cltbld', 12:11:11 INFO - 'MAIL': '/var/mail/cltbld', 12:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:11 INFO - 'MOZ_NO_REMOTE': '1', 12:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:11 INFO - 'NO_EM_RESTART': '1', 12:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:11 INFO - 'PWD': '/builds/slave/test', 12:11:11 INFO - 'SHELL': '/bin/bash', 12:11:11 INFO - 'SHLVL': '1', 12:11:11 INFO - 'TERM': 'linux', 12:11:11 INFO - 'TMOUT': '86400', 12:11:11 INFO - 'USER': 'cltbld', 12:11:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:11 INFO - '_': '/tools/buildbot/bin/python'} 12:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:11:11 INFO - Running setup.py (path:/tmp/pip-h7WkBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:11:11 INFO - Running setup.py (path:/tmp/pip-MrISKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:11:11 INFO - Running setup.py (path:/tmp/pip-KjGf1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:11:11 INFO - Running setup.py (path:/tmp/pip-B7NDhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:11:12 INFO - Running setup.py (path:/tmp/pip-1T8zGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:11:12 INFO - Running setup.py (path:/tmp/pip-NpgPqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:11:12 INFO - Running setup.py (path:/tmp/pip-gcKcSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:11:12 INFO - Running setup.py (path:/tmp/pip-NYy7br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:11:12 INFO - Running setup.py (path:/tmp/pip-AuWZuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:11:12 INFO - Running setup.py (path:/tmp/pip-A80K9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:11:12 INFO - Running setup.py (path:/tmp/pip-DW7DQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:11:12 INFO - Running setup.py (path:/tmp/pip-d8LmkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:11:12 INFO - Running setup.py (path:/tmp/pip-440eLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:11:12 INFO - Running setup.py (path:/tmp/pip-9bwVGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:12 INFO - Running setup.py (path:/tmp/pip-wnbqAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:11:12 INFO - Running setup.py (path:/tmp/pip-pyk8ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:11:12 INFO - Running setup.py (path:/tmp/pip-ecOFh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:11:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:11:12 INFO - Running setup.py install for manifestparser 12:11:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Running setup.py install for mozcrash 12:11:13 INFO - Running setup.py install for mozdebug 12:11:13 INFO - Running setup.py install for mozdevice 12:11:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Running setup.py install for mozfile 12:11:13 INFO - Running setup.py install for mozhttpd 12:11:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Running setup.py install for mozinfo 12:11:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Running setup.py install for mozInstall 12:11:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:11:13 INFO - Running setup.py install for mozleak 12:11:13 INFO - Running setup.py install for mozlog 12:11:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:11:14 INFO - Running setup.py install for moznetwork 12:11:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:11:14 INFO - Running setup.py install for mozprocess 12:11:14 INFO - Running setup.py install for mozprofile 12:11:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:11:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:11:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:11:14 INFO - Running setup.py install for mozrunner 12:11:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:11:14 INFO - Running setup.py install for mozscreenshot 12:11:14 INFO - Running setup.py install for moztest 12:11:14 INFO - Running setup.py install for mozversion 12:11:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:11:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:11:14 INFO - Cleaning up... 12:11:14 INFO - Return code: 0 12:11:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11:14 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')]} 12:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:14 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')]} 12:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:14 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:14 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 12:11:14 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 12:11:14 INFO - Using env: {'DISPLAY': ':0', 12:11:14 INFO - 'HOME': '/home/cltbld', 12:11:14 INFO - 'LANG': 'en_US.UTF-8', 12:11:14 INFO - 'LANGUAGE': 'en_US:en', 12:11:14 INFO - 'LOGNAME': 'cltbld', 12:11:14 INFO - 'MAIL': '/var/mail/cltbld', 12:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:14 INFO - 'MOZ_NO_REMOTE': '1', 12:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:14 INFO - 'NO_EM_RESTART': '1', 12:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:14 INFO - 'PWD': '/builds/slave/test', 12:11:14 INFO - 'SHELL': '/bin/bash', 12:11:14 INFO - 'SHLVL': '1', 12:11:14 INFO - 'TERM': 'linux', 12:11:14 INFO - 'TMOUT': '86400', 12:11:14 INFO - 'USER': 'cltbld', 12:11:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:14 INFO - '_': '/tools/buildbot/bin/python'} 12:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:11:15 INFO - Running setup.py (path:/tmp/pip-ozclM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:11:15 INFO - Running setup.py (path:/tmp/pip-V9nKvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:11:15 INFO - Running setup.py (path:/tmp/pip-fpJzfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:11:15 INFO - Running setup.py (path:/tmp/pip-ptVXhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:11:15 INFO - Running setup.py (path:/tmp/pip-BPU_iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:11:15 INFO - Running setup.py (path:/tmp/pip-UEIURU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:11:15 INFO - Running setup.py (path:/tmp/pip-Os5jPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:11:15 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)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:11:15 INFO - Running setup.py (path:/tmp/pip-KCdu28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:11:15 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)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:11:15 INFO - Running setup.py (path:/tmp/pip-8KrHku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:11:15 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)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:11:15 INFO - Running setup.py (path:/tmp/pip-Db95NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:11:15 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)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:11:15 INFO - Running setup.py (path:/tmp/pip-Zp1eWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:11:15 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)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:11:15 INFO - Running setup.py (path:/tmp/pip-rbsGjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:11:15 INFO - Running setup.py (path:/tmp/pip-82LRjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:11:16 INFO - Running setup.py (path:/tmp/pip-VxAOPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:16 INFO - Running setup.py (path:/tmp/pip-cLfk3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:11:16 INFO - Running setup.py (path:/tmp/pip-w_ySck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:11:16 INFO - Running setup.py (path:/tmp/pip-w5Ajt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:11:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:18 INFO - Downloading blessings-1.6.tar.gz 12:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:11:18 INFO - Installing collected packages: blessings 12:11:18 INFO - Running setup.py install for blessings 12:11:18 INFO - Successfully installed blessings 12:11:18 INFO - Cleaning up... 12:11:18 INFO - Return code: 0 12:11:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:11:18 INFO - Reading from file tmpfile_stdout 12:11:18 INFO - Current package versions: 12:11:18 INFO - argparse == 1.2.1 12:11:18 INFO - blessings == 1.6 12:11:18 INFO - blobuploader == 1.2.4 12:11:18 INFO - docopt == 0.6.1 12:11:18 INFO - functools32 == 3.2.3-2 12:11:18 INFO - jsonschema == 2.5.1 12:11:18 INFO - manifestparser == 1.1 12:11:18 INFO - mozInstall == 1.12 12:11:18 INFO - mozcrash == 0.17 12:11:18 INFO - mozdebug == 0.1 12:11:18 INFO - mozdevice == 0.48 12:11:18 INFO - mozfile == 1.2 12:11:18 INFO - mozhttpd == 0.7 12:11:18 INFO - mozinfo == 0.9 12:11:18 INFO - mozleak == 0.1 12:11:18 INFO - mozlog == 3.2 12:11:18 INFO - moznetwork == 0.27 12:11:18 INFO - mozprocess == 0.22 12:11:18 INFO - mozprofile == 0.28 12:11:18 INFO - mozrunner == 6.11 12:11:18 INFO - mozscreenshot == 0.1 12:11:18 INFO - mozsystemmonitor == 0.3 12:11:18 INFO - moztest == 0.7 12:11:18 INFO - mozversion == 1.4 12:11:18 INFO - psutil == 3.1.1 12:11:18 INFO - requests == 1.2.3 12:11:18 INFO - wsgiref == 0.1.2 12:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11:18 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')]} 12:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:18 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')]} 12:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:18 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:18 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 12:11:18 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 12:11:18 INFO - Using env: {'DISPLAY': ':0', 12:11:18 INFO - 'HOME': '/home/cltbld', 12:11:18 INFO - 'LANG': 'en_US.UTF-8', 12:11:18 INFO - 'LANGUAGE': 'en_US:en', 12:11:18 INFO - 'LOGNAME': 'cltbld', 12:11:18 INFO - 'MAIL': '/var/mail/cltbld', 12:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:18 INFO - 'MOZ_NO_REMOTE': '1', 12:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:18 INFO - 'NO_EM_RESTART': '1', 12:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:18 INFO - 'PWD': '/builds/slave/test', 12:11:18 INFO - 'SHELL': '/bin/bash', 12:11:18 INFO - 'SHLVL': '1', 12:11:18 INFO - 'TERM': 'linux', 12:11:18 INFO - 'TMOUT': '86400', 12:11:18 INFO - 'USER': 'cltbld', 12:11:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:18 INFO - '_': '/tools/buildbot/bin/python'} 12:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 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)) 12:11:18 INFO - Cleaning up... 12:11:18 INFO - Return code: 0 12:11:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:11:18 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')]} 12:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:18 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')]} 12:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:18 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', '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 12:11:18 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 12:11:18 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 12:11:18 INFO - Using env: {'DISPLAY': ':0', 12:11:18 INFO - 'HOME': '/home/cltbld', 12:11:18 INFO - 'LANG': 'en_US.UTF-8', 12:11:18 INFO - 'LANGUAGE': 'en_US:en', 12:11:18 INFO - 'LOGNAME': 'cltbld', 12:11:18 INFO - 'MAIL': '/var/mail/cltbld', 12:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:18 INFO - 'MOZ_NO_REMOTE': '1', 12:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:18 INFO - 'NO_EM_RESTART': '1', 12:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:18 INFO - 'PWD': '/builds/slave/test', 12:11:18 INFO - 'SHELL': '/bin/bash', 12:11:18 INFO - 'SHLVL': '1', 12:11:18 INFO - 'TERM': 'linux', 12:11:18 INFO - 'TMOUT': '86400', 12:11:18 INFO - 'USER': 'cltbld', 12:11:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:18 INFO - '_': '/tools/buildbot/bin/python'} 12:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:11:19 INFO - Cleaning up... 12:11:19 INFO - Return code: 0 12:11:19 INFO - Running post-action listener: _resource_record_post_action 12:11:19 INFO - Running post-action listener: _start_resource_monitoring 12:11:19 INFO - Starting resource monitoring. 12:11:19 INFO - ##### 12:11:19 INFO - ##### Finished create-virtualenv step (success) 12:11:19 INFO - ##### 12:11:19 INFO - ##### 12:11:19 INFO - ##### Running install step. 12:11:19 INFO - ##### 12:11:19 INFO - Running pre-action listener: _resource_record_pre_action 12:11:19 INFO - Running main action method: install 12:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:11:19 INFO - Reading from file tmpfile_stdout 12:11:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:11:19 INFO - Reading from file tmpfile_stdout 12:11:19 INFO - Output received: 12:11:19 INFO - Usage: mozinstall [options] installer 12:11:19 INFO - Options: 12:11:19 INFO - -h, --help show this help message and exit 12:11:19 INFO - -d DEST, --destination=DEST 12:11:19 INFO - Directory to install application into. [default: 12:11:19 INFO - "/builds/slave/test"] 12:11:19 INFO - --app=APP Application being installed. [default: firefox] 12:11:19 INFO - mkdir: /builds/slave/test/build/application 12:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:11:35 INFO - Reading from file tmpfile_stdout 12:11:35 INFO - Output received: 12:11:35 INFO - /builds/slave/test/build/application/firefox/firefox 12:11:35 INFO - Running post-action listener: _resource_record_post_action 12:11:35 INFO - ##### 12:11:35 INFO - ##### Finished install step (success) 12:11:35 INFO - ##### 12:11:35 INFO - ##### 12:11:35 INFO - ##### Running run-tests step. 12:11:35 INFO - ##### 12:11:35 INFO - Running pre-action listener: _resource_record_pre_action 12:11:35 INFO - Running main action method: run_tests 12:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:11:35 INFO - Python 2.7.3 12:11:35 INFO - Return code: 0 12:11:35 INFO - grabbing minidump binary from tooltool 12:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:35 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 0x21e93b0>, '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 0x21ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ea740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:11:35 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 12:11:35 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 12:11:35 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 12:11:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:11:35 INFO - Return code: 0 12:11:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:11:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:11:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:11:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:11:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:11:35 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:11:35 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:11:35 INFO - Using env: {'DISPLAY': ':0', 12:11:35 INFO - 'HOME': '/home/cltbld', 12:11:35 INFO - 'LANG': 'en_US.UTF-8', 12:11:35 INFO - 'LANGUAGE': 'en_US:en', 12:11:35 INFO - 'LOGNAME': 'cltbld', 12:11:35 INFO - 'MAIL': '/var/mail/cltbld', 12:11:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:11:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:35 INFO - 'MOZ_NO_REMOTE': '1', 12:11:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:35 INFO - 'NO_EM_RESTART': '1', 12:11:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:35 INFO - 'PWD': '/builds/slave/test', 12:11:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:11:35 INFO - 'SHELL': '/bin/bash', 12:11:35 INFO - 'SHLVL': '1', 12:11:35 INFO - 'TERM': 'linux', 12:11:35 INFO - 'TMOUT': '86400', 12:11:35 INFO - 'USER': 'cltbld', 12:11:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305', 12:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:35 INFO - '_': '/tools/buildbot/bin/python'} 12:11:35 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:11:35 INFO - mozversion application_buildid: 20160704111823 12:11:35 INFO - mozversion application_changeset: fdffe351484e4abbd32f686424ff840ae05f0992 12:11:35 INFO - mozversion application_display_name: Nightly 12:11:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:11:35 INFO - mozversion application_name: Firefox 12:11:35 INFO - mozversion application_remotingname: firefox 12:11:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:11:35 INFO - mozversion application_vendor: Mozilla 12:11:35 INFO - mozversion application_version: 50.0a1 12:11:35 INFO - mozversion platform_buildid: 20160704111823 12:11:35 INFO - mozversion platform_changeset: fdffe351484e4abbd32f686424ff840ae05f0992 12:11:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:11:35 INFO - mozversion platform_version: 50.0a1 12:11:35 INFO - using testdate: 1467659495 12:11:35 INFO - actual date: 1467659495 12:11:35 INFO - starting webserver on 'localhost:56871' 12:11:35 INFO - SUITE-START | Running 2 tests 12:11:35 INFO - TEST-START | dromaeo_css 12:11:35 INFO - operating with platform_type : linux_ 12:11:35 INFO - Initialising browser for dromaeo_css test... 12:11:35 INFO - TEST-INFO | started process 25126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ5VDva/profile http://localhost:56871/getInfo.html) 12:11:40 INFO - PROCESS | 25126 | __metrics Screen width/height:1600/1200 12:11:40 INFO - PROCESS | 25126 | colorDepth:24 12:11:40 INFO - PROCESS | 25126 | Browser inner width/height: 1024/697 12:11:40 INFO - PROCESS | 25126 | __metrics 12:11:41 INFO - PROCESS | 25126 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:11:42 INFO - TEST-INFO | 25126: exit 0 12:11:42 INFO - Browser initialized. 12:11:42 INFO - Running cycle 1/1 for dromaeo_css test... 12:11:42 INFO - TEST-INFO | started process 25207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ5VDva/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:54 INFO - PROCESS | 25207 | RSS: Main: 158777344 12:11:54 INFO - PROCESS | 25207 | 12:12:46 INFO - PROCESS | 25207 | 1467659566276 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] 12:14:58 INFO - PROCESS | 25207 | Cycle 1(1): loaded http://localhost:56871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56871/tests/dromaeo/cssquery-ext.html) 12:14:59 INFO - PROCESS | 25207 | RSS: Main: 262893568 12:14:59 INFO - PROCESS | 25207 | 12:18:02 INFO - PROCESS | 25207 | Cycle 1(1): loaded http://localhost:56871/tests/dromaeo/cssquery-ext.html (next: http://localhost:56871/tests/dromaeo/cssquery-jquery.html) 12:18:02 INFO - PROCESS | 25207 | RSS: Main: 240209920 12:18:02 INFO - PROCESS | 25207 | 12:21:04 INFO - PROCESS | 25207 | Cycle 1(1): loaded http://localhost:56871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56871/tests/dromaeo/cssquery-mootools.html) 12:21:05 INFO - PROCESS | 25207 | RSS: Main: 240119808 12:21:05 INFO - PROCESS | 25207 | 12:24:07 INFO - PROCESS | 25207 | Cycle 1(1): loaded http://localhost:56871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56871/tests/dromaeo/cssquery-prototype.html) 12:24:08 INFO - PROCESS | 25207 | RSS: Main: 234991616 12:24:08 INFO - PROCESS | 25207 | 12:27:11 INFO - PROCESS | 25207 | Cycle 1(1): loaded http://localhost:56871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56871/tests/dromaeo/cssquery-yui.html) 12:27:12 INFO - PROCESS | 25207 | RSS: Main: 213520384 12:27:12 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | Cycle 1(1): loaded http://localhost:56871/tests/dromaeo/cssquery-yui.html (next: http://localhost:56871/tests/dromaeo/cssquery-dojo.html) 12:30:15 INFO - PROCESS | 25207 | RSS: Main: 276303872 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | __start_tp_report 12:30:15 INFO - PROCESS | 25207 | _x_x_mozilla_page_load 12:30:15 INFO - PROCESS | 25207 | _x_x_mozilla_page_load_details 12:30:15 INFO - PROCESS | 25207 | |i|pagename|runs| 12:30:15 INFO - PROCESS | 25207 | |0;dojo.html;2606.2702443315866;2620.92137235883;2640.894364225431;2644.272824973132;2648.920532384028;4590.540945905408;4638.188317044513;4674.228752255878;4705.670603057787;4720.881977950553;4664.720116792986;4700;4711.740854253023;4727.196376615975;4746.145693775119;4326.502452218004;4329.437173167499;4366.170427618758;4375.234333991555;4395.978020109895;4356.89107772305;4425.601695847373;4456.554344565534;4464.3303504474425;4496.752678602676;4404;4444.644428445733;4461.973746038429;4462.97768511157;4498.055408364247;4242.172776308621;4265;4287.3140297552245;4292.0772034012525;4331.891702707458;4275;4297.806598703066;4347.717398369127;4352.804123814436;4419.867403977853;4784.928226076611;4787.736674482902;4794.376731024944;4801.567858892681;4808.903821923542;4913.115639184945;4987.376577927759;5060.696358218519;5073.873153171164;5153.407358153823;5107.668001579886;5149.48505149482;5151.330327057496;5167.948320516822;5171.560417364529;4602.493725690171;4786.3777708898315;4812.759362031885;4830.975845120752;4832.9275060874115;5116.232565115188;5148.176291793295;5202.7918883245;5278.419373868871;5298.761555730001;5060;5073.492650734971;5074.314967479417;5075.695458272516;5081.110805609003;4938.407391113089;5097.311862898461;5115.590752739847;5142.357205349332;5159.380874295033;4993.425756038102;5031.748412579356;5049.545540901337;5071.8985620287385;5082;5052.141136006888;5053.0651829410945;5056.0140772549;5062.645614807002;5112.36095488064;4169.874903752892;4196.118815048813;4332.631726303236;4356.782160891943;4397.384366188736;3707.35121353762;3733.290674771785;3739.7943113128495;3775;3785.1483416231677;4321.330193819963;4323.546027667113;4337.262665346899;4338.652907767371;4386.013147041954;4957.727324997088;5001.224810154432;5003.074431230234;5017.12200364942;5040.747962601855;4318.114786468766;4354.586314300136;4364.323529852878;4364.367166760802;4373.934390984138;4572.611328037154;4574.519675434098;4590.655700822452;4597.241455159928;4613.5847773700525;4655;4743.83396581118;4771.6898401603785;4786.593139583175;4787.281907713871;5068;5104.489551044866;5128.230765385222;5128.871778205575;5175.171972484384;4803.8318658848175;4808.495108013748;4812.735299558558;4818.10864989978;4856.854294371175;4842.83050093245;4960.627952903619;4964.081644895706;4987.152184128634;5096.413912399973;5082.085224659597;5104.9744751276;5114.258432527188;5119.692818430906;5159.974200129125;4974.353334066548;4976.576990955665;4977.328060711902;4980.900381992412;5013.674111182761;4740.6207503398955;4917.655764096479;4952.207646776498;4952.207646776498;4970.6023518117745;4889.926651100165;4901.950980490292;4909.828156014522;4959.9008019838675;4960.528749768766;4945.307656927961;5004.174311238605;5006.299118123393;5007.198848184273;5048.873778155576;4696.624270058319;4728.810847566197;4763.476017637988;4840.515948405131;4867.926981095357 12:30:15 INFO - PROCESS | 25207 | |1;ext.html;545.3797077587981;584.541135208861;589.051626880722;599.5353600959257;608.5861614102408;26243.4751304974;38854.80572597137;39692.60307396925;39757.8012109939;39780.602193978055;39518.60481395185;39969.20061598766;40039.799801000954;40052.799736001354;40053.39919901204;7465.178830328659;7573.318401343878;7579;7861;8022.598870056503;7618.200088990659;10065.144462720678;10339.689809305733;10356.119729822974;10735.033846953773;10436.06075453209;10498.317609355405;10505.21210909181;10507.369557826516;10518.474076296194;7500.962495187544;7689.307962283366;10353.689389318295;10426.73933151666;10428.165746740318;7651.732189373345;10058.597656093747;10401.271910966236;10404.843927341097;10415.323004004715;35856.462153067725;36221.27557448862;36335.636643633756;38932.610673893185;39125.80437097825;2912.155474912273;2977.895773647912;2979.4190132924086;3389.3405240518678;3448.3965306071586;30004.8499757502;30005.699943000727;30629;30881.227969300722;31661;3532.0993146747674;3536.398812201932;3581.946270805914;3583.8387272572795;3627.5646922369483;264623;266483;267153;267619;268002;57136;57928.71035644795;57993.13010304849;57994;57999.71000144972;60107.09839352413;60254.69872650609;60264.09603855946;60439;60609;14707.264636768119;15140.091594504365;15153.848461515243;15154.16652084146;15162.696746065018;10350.741231469274;11118.499667514981;11336.773264534828;11435.94282028601;11472.31166130035;18448.446546603624;18570.535736606424;18580.81419185818;18600.255989760528;18622.16200270991;6767.893711602797;6949.861002779916;7130.607816570035;7213.6195055631515;7220.530665506725;817.3951276055676;853.3727710133047;872.7992561710842;916.862470629411;971.5433746139303;27193.32016699598;27979.135083379893;28320.858395707888;28600.14199574016;28635;927.6474939522938;945.6075728572703;1015.5937624950079;1054.1619412567027;1079.3469950679882;14574.927125364517;14988.775168372484;15001.2499375033;15332.616684582752;15355.462558810388;373744;375340;376037;377470;378033;48480.787980300775;49187;49485.257721134214;49566.75216623966;49598.25602615964;1052.7894421115807;1116.9497372618089;1150.327058670687;1171.8945294923499;1186.9821952670716;27191.320216994733;29261.268468288465;29577.556336654536;29925;30149.397012060075;40129.598704012584;40551.391729124676;40597;40636.79681601573;40686.389704153866;253037;253681;255539;255612;256529;30680;37605.62394376021;38825.41761873518;39096;41034.38448423336;41136.58863411328;42100;42102;43105.13789724251;43163.920901977704;36212.63787362093;36412.27175456423;36508.26983460369;36628.816855916615;36709.44935826018;36465.07831436198;36519.26961460809;36623.63376366202;36725.44911826271;36880;34944.65055349516;35261.294774104885;35796.105097372776;36056.819715901256;36145;30056.849715751283;32959.50560741639;33117.66882331146;33243.335133296714;33277.83361083179;25060.498790023732;25358.74641253564;25642.358941026625;25749.3562660935;25762.484750305262 12:30:15 INFO - PROCESS | 25207 | |2;jquery.html;360.5889286213716;363.89628955747617;380.34200832559674;385.3026022898552;395.4858683711175;16197.433089841843;17117.14414279286;17943.10284485777;17946.192421341053;17948.461546153605;15452.613684657888;16083.758743618826;16480.67038659229;16520.504384868473;16584.336626534925;5152.484751524837;5363.249145119687;5408.648437851547;5411.756470958816;5414.269073675063;3870.748401353917;4016.236914986158;5284.154535274357;5972.701364931758;6297.3387794281625;6354.364563543631;6356.523260755462;6388.297287298416;6397.904031439532;6400.071989561534;5323.334583177103;5648.293963254593;5649.0396632572565;5722.54219662426;5739.684317362543;3422.178677117499;5143.588512918957;5435;5444.292242008513;5473.698946557938;12183.634490965285;12404.317762523058;12411;12427.565035223814;12443.191192572454;1969.2221572478934;1972.6646470100118;2024.6760518316999;2222.511047569532;2261.0842608743487;8732.083131271189;9050.592723327467;9400.482973436458;9490.240780737524;10259;1666.3334666133521;1672.6989141954443;1745.8428741413206;1768.6674675852316;1835.0366057819617;67883.3211667887;68445.65777171082;69259.30740692579;73128.63435682788;74366.99999999946;9223.650436656231;9572.377795443273;10299.227557933034;10421.68734937953;10533.104686101768;13881.791773123412;13886.305684715926;13942.58172254834;14103.2948352584;14294.999350045397;7161.355478007004;7319.707211711579;7392.741254056083;7452.739154129579;7452.925470745223;7125.073740413713;7161.785146445615;7269.89095163573;7279.708811647475;7393.963030184815;4135.462389889355;4161.25097482456;4204.180184863983;4283.914321713611;4596.17268891596;1705.3178728508449;1715.6654452381665;1760.5686606781164;1816.1373347659755;1897.8671492995634;755.3051192902543;786.7679034684782;843.2537204573873;866.2030931542996;911.444019148319;16750.916245418695;16987.150642467826;17076.146192690565;17709.911450442924;17723.379681711078;840.6175190288404;850.7150104714866;865.34233982174;886.6674996876171;911.2345629671108;9543.570539325747;9978.600855965826;9989.850152247722;10049.949750251202;10215.489225538693;380822;386259;387296;388579;390083;52216.47783522116;63413.68293158505;73465;76043;77467.61266193633;917.7980844214262;936.3398803843274;943.118184497497;948.0993056596261;951.07270411347;16345.918270408572;16812.24344904507;16892.324307027582;17092.743608845627;17300.307987680353;37336.626633733315;39985.600143998185;40455.393169103074;41500.37749433701;43278.35082473703;51988.22017669814;54827.451725482235;55089;55199.17201241904;55240.17139742827;7708.421868359784;7730.265624765639;7762.961185194038;7820.960895195488;7952.085510166405;6501.08984742127;8185.8772118419465;9986.700398988041;11981.28112313264;12124.964424982561;10219.25359421963;10485;10569.788604227719;10628.096611788085;10733.141348692243;9498.24014078886;9800.264980126662;10455.111315538265;10621.522031508446;10670.786584268426;10465;10546.683599492027;10691.198160138176;10735.248532602955;10843.240973131806;7862.60686965638;7998.040235171584;8049.557274349967;8055.637496312797;8370.53962032094;10079.596816127567;10397.896021039995;10647.733806654896;10652.041316281262;10726.249162558546 12:30:15 INFO - PROCESS | 25207 | |3;mootools.html;1347.8786909178175;1410.42877634558;1441.3657990484187;1682.5625337412268;1694.390019592947;7580.090389153303;7992.200779922005;8018;8083.4341596088225;8096.95951520243;6850.69171887265;7433.776986690395;7675.961620191905;7702;7939.722109726161;2196.494806194572;2207.514346843692;2213.513027134028;2214.3910424633273;2225.610518159324;2205.4376134085787;2206.702095217141;2250.0212407602744;2251.4596496840804;2252.8197744180425;1861.3671351740406;2125.319897632758;2186.158329043322;2195.121951219509;2215.191455118878;2214.047959377467;2218.7559368469456;2242.2040175737543;2242.730872295335;2257.593633146033;2221.9888900555393;2224.143704673696;2224.354937068248;2226.699395581592;2227.008981003454;7991.120976692559;7996.920030799675;8039.718609848685;8041.718539851077;8043.95978020112;4524.276115821453;4567.977160114178;4619.95380046202;4627.8611641650805;4632.745199014053;2887.076135636597;2959.8076125051803;3015.834129122897;3022.9244268893235;3031.9090427287215;879.134052957836;889.6841621224437;895.417978314101;902.1835239108617;912.5300470257822;10632.681019569425;10649.78700425995;10685.252032357737;10697.786044279072;10716.571337146504;4050.270951228807;4130.91738165235;4281.7002809803635;4285.207236661166;4318.201132790444;9057.954710226406;9114.544272786334;9128.224100951493;9144.908550914539;9146;4671.43942726875;4674.95325046752;4682.789274482657;4686.95313046872;4689.50760170184;4059.5534491205945;4206.663466922639;4211.263028969979;4211.978940105279;4224.936625950613;3647.8176091195332;3699.9445008324897;3710.6474884885893;3744.1762812181278;3749.6625303722794;1058.6136060337922;1186.0630102219322;1187.2757617853104;1194.6893807610084;1198.1433275208267;770.8689522781141;801.6072124658875;830.1781236575868;844.5566077809076;861.1001503428931;5316.441773613715;5358.571314294847;5393.568514518829;5500.834974950758;5517;818.5825229133185;831.6236628380041;877.5217506458995;891.1133422244908;892.9330300227509;3649.4708267301626;3738.9439158412647;3743.644353786386;3767.6609105180664;3811.1805961718364;9522.809543809086;9561.9043809561;9922.652707155215;9949.005099489994;9961.452120133317;9679.467629280458;9681.322307438411;9687.70936871895;9696.51517424126;9722.854157187649;6496.155499784998;7047.43620510358;7324.498477812036;7327.340539351484;7439.8140046499275;5355.116405793001;5378.1663842104535;5428.158635411518;5519.337679478488;5598.720063996702;8916.821663566821;9110.590023449093;9113.453192808453;9118.544072796201;9127.634894604142;8549.871751923602;9096.272298215994;9106.726798196065;9111.589978451118;9128.406653567497;6731.225909020525;6992.895106573304;7003.509754317352;7027.683754231174;7034.437245020488;7386;7468.738594149178;7533.209013053551;7535.020447341811;7586.924130758843;5442.499697587199;6941.826454338682;6944.791656250321;6994.545354551938;7041.929580704127;6607.537472376887;6627.900581491378;6638.17022872141;6646.700898459678;6836.692348844414;6135.570510064431;6145.13968044483;6145.6927153641245;6147.108669243024;6152.600080994721;4566.725996440225;4613.146567884952;4647.767611619338;4654.581087702123;4770.260609605517;4483.461984561874;4504.77476126199;4631.791569379318;4645.3032045193495;4646.83736069236 12:30:15 INFO - PROCESS | 25207 | |4;prototype.html;307.5755457468693;309.18067122126365;314.70417807261174;314.7717904519223;316.1747838142449;4918.3114363989025;4931.728754918478;4952.678075925067;4973.328600638913;4986.875328116799;4831.227003679412;4864.348929833241;4929.556339929406;4933.432655244648;4942.777575009124;3623.456481527772;3770.5852356240794;3788.4317352397225;3796.2027974125467;3829.4064420014943;3745.5392396965203;3813.8665146719873;3864.188520410717;3879.2823327684328;3907.628775266345;3794.2221844521805;3818.9045273868237;3827.942580861289;3828.0812604974885;3843.077661361281;3725.4411838224214;3815.275097731422;3831;3832.693384529245;3859.073822282646;3371.8482668279985;3384.13704505352;3395.7792743471596;3396.8980930572125;3410.693037626601;4751.477337492873;4787.473377928425;4816.975915120437;4829.589484893788;4831.95168048322;4157.3185295484245;4321.37340085689;4336.3278691802825;4336.56634336567;4353.586409291112;5078.4413714491375;5085.059264036166;5086.872828179288;5100.719460429675;5103.540681338697;3649.1059690375764;3659.6157403472516;3666.8349924253207;3672.540932383452;3680.2271522980204;5209.973950130225;5336.733163341856;5373.468561460004;5402.972985135049;5415.864603384907;3736.850525978985;3746.5316835395574;3750.3811871041516;3752.2870654575545;3769.679577235911;3795.1081495848453;3801.790901500389;3806.8667596633986;3808;3815.893390916603;4105.404716316118;4374.431323927869;4385.232584297735;4385.451818522684;4396;5130.333056702605;5130.691673623202;5143.639945203875;5168.870778230575;5197.29836472079;1280.8975281977418;1313.3105119812176;1314.5859054397833;1315.2963164706837;1321.914075585084;796.6733639208013;830.8047608811925;835.1022650650453;842.2503971465401;847.3771777743353;4410.823567057282;4500.639948804088;4539.228331183706;4549.909001819945;4553.658475614276;5263.421023687391;5269.736513174326;5282.894342113136;5305.946940530545;5308.946910530923;4500.617447516997;4523.615492683093;4542.613877820422;4543.5910768031035;4556.794944227518;2641.6697912760906;2829.627630599158;2830.4056148208697;2835.4754370441533;2838.155199120547;4978.316046125841;4986.775595098229;5006.199008158677;5010.749462526859;5012.974935125374;5268.6575372600655;5387.24578559002;5423.83728488146;5424.186372044146;5432.414606359863;4966.8261610844165;4975.333263356743;4978.950210497921;4991.376077990251;5012.649114562018;5310.920336194883;5311.973440132774;5317.308749862493;5330.600204984564;5332.986732520809;4977.9751101244265;5184.688918664892;5192;5212.609054321017;5248.6588371755715;4952.851414457572;4958.355413796184;4962.975185124195;4965.677230979974;4978.32792572998;3324.9501257480674;3387.000834753803;3443.27691184854;3462.688358047788;3472.9652703472643;4530;4704.482506924167;4776.880577985578;4791.425028996543;4801.207800712983;4568.337591049346;4573.908521829611;4586.312053192048;4602.930956035595;4606.953930460652;4576.542345765397;4591.783177458043;4643.0516621944635;4651.651126165619;4674.649401294849;4312.827486900489;4516.525764794649;4521.276595744665;4524;4528.622473201595;4594.425696787902;4862.513748625251;5000.424951130666;5162.199859021857;5186.533212010937;5026.421961474477;5036.420811606566;5037.7733002014265;5065.138926382598;5090.796368145233 12:30:15 INFO - PROCESS | 25207 | |5;yui.html;653.0824192010227;659.9802005939822;692.162483395092;695.3845846425914;748.9550626962383;12703.809442858354;13126.081174317802;13142.802857957138;13241.271730054843;13251.602451926457;12739.745205095893;13369.39837707303;13418.664533386645;13455.394507247172;13469.191848489098;624.6377101281246;772.5750837039619;782.0654318089885;785.1128225105623;785.3795501553766;764.4457768118125;792.7582087463321;793.896793416855;794.2494342846013;795.7334293011847;827.5986146718836;828.7679449754079;830.485099238473;830.767385132164;831.2726364431123;652.1424327009967;802.3100133884855;824.9051359093721;825.22428916818;825.5376988886243;603.1074010464494;605.9818205453844;606.4238972975646;606.6572386601556;606.6875559087074;13453.66365840852;13459.596212113653;13575.796363054464;13586.320683965861;13616.93191534046;12862.935685321607;13386.39761210748;13395.665108372272;13444.467638843356;13520.18878867271;11625.825612615818;11642.59250926222;11704.356260405675;11870.643880683594;12145.939270303681;4145.937810932838;4223.619874211336;4267.551907049746;4337.761423121727;4344.63070638996;65169.34830651728;65882.67058664723;65923;66188;66587.33412665859;10334.121599663962;10666.520006599721;10686.465676716132;10690.679279621623;10725.14198864089;19882.70175947362;19884.70172947407;19890.90054549747;19894.30369937045;19912.303069392503;6500.739970401226;6732.798016059526;6801.727930882709;6858.588484690935;6870.553414028072;3554.360215161244;3643.4352675335367;3713.2573485303046;3719.907002324909;3725.70194384454;2945.4403663303906;3071.6774738652566;3073.1548824073557;3074.8923787667322;3077.046115704139;504.7097918696764;505.56268827464714;514.4675261104738;517.6014468858957;524.8005757812083;533.9866503337448;538.488435985815;539.5252178083261;557.6152454806171;559.4014404587052;7220.927790722026;7243.89134162988;7493.775186744407;7504.249575042452;7665.946064415913;444.4133743458668;493.9306401640408;512.8974205158983;547.6248769592842;548.8929658716512;3668.523091998023;3698;3717.1078941054493;3722.4230244312175;3823.388257878726;104711.76441178063;106380;107846;108832;109411;91839.54080229557;94228.52885735527;95196;95813;96152;47263.29105063427;47488;80560;81835.5908220467;82477.58761206156;7150;7190.20907700163;7277.781666550012;7348.853022939618;7411.66647500853;45872.31191532197;47247;47412.2888156671;48961.51038489569;49009.50990490192;60602.696986514784;62735;64813;69898;70774.29225707677;11181.72045698864;11562.19064665499;11609.709757256136;11863.644090677293;12405.255684658949;12452.750944981231;12948.28784416866;13323.000774941724;13435.865641343462;13602.38789254466;11987.700307492383;12079.698007549881;12243.632691018927;12449.066320025853;12843.743125137631;12198.878011219775;12324.198927069712;12408.441620127296;12910.741785164431;13214.801777973145;11367.772644547229;12308.753824923273;12392.31842248685;12419.627411177678;12450.937745311578;10300.639477618248;10415.895841041493;10511.78976420452;10683.145348372267;10758.46207689628;10003.649872254437;10407.427591482541;10434.141211767559;10616.787664246518;10628.202884783517 12:30:15 INFO - PROCESS | 25207 | __end_tp_report 12:30:15 INFO - PROCESS | 25207 | __start_cc_report 12:30:15 INFO - PROCESS | 25207 | _x_x_mozilla_cycle_collect,1006 12:30:15 INFO - PROCESS | 25207 | __end_cc_report 12:30:15 INFO - PROCESS | 25207 | __startTimestamp1467660615702__endTimestamp 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | ------- Summary: start ------- 12:30:15 INFO - PROCESS | 25207 | Number of tests: 6 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | [#0] dojo.html Cycles:165 Average:4691.74 Median:4808.90 stddev:499.10 (10.4%) stddev-sans-first:473.06 12:30:15 INFO - PROCESS | 25207 | Values: 2606.3 2620.9 2640.9 2644.3 2648.9 4590.5 4638.2 4674.2 4705.7 4720.9 4664.7 4700.0 4711.7 4727.2 4746.1 4326.5 4329.4 4366.2 4375.2 4396.0 4356.9 4425.6 4456.6 4464.3 4496.8 4404.0 4444.6 4462.0 4463.0 4498.1 4242.2 4265.0 4287.3 4292.1 4331.9 4275.0 4297.8 4347.7 4352.8 4419.9 4784.9 4787.7 4794.4 4801.6 4808.9 4913.1 4987.4 5060.7 5073.9 5153.4 5107.7 5149.5 5151.3 5167.9 5171.6 4602.5 4786.4 4812.8 4831.0 4832.9 5116.2 5148.2 5202.8 5278.4 5298.8 5060.0 5073.5 5074.3 5075.7 5081.1 4938.4 5097.3 5115.6 5142.4 5159.4 4993.4 5031.7 5049.5 5071.9 5082.0 5052.1 5053.1 5056.0 5062.6 5112.4 4169.9 4196.1 4332.6 4356.8 4397.4 3707.4 3733.3 3739.8 3775.0 3785.1 4321.3 4323.5 4337.3 4338.7 4386.0 4957.7 5001.2 5003.1 5017.1 5040.7 4318.1 4354.6 4364.3 4364.4 4373.9 4572.6 4574.5 4590.7 4597.2 4613.6 4655.0 4743.8 4771.7 4786.6 4787.3 5068.0 5104.5 5128.2 5128.9 5175.2 4803.8 4808.5 4812.7 4818.1 4856.9 4842.8 4960.6 4964.1 4987.2 5096.4 5082.1 5105.0 5114.3 5119.7 5160.0 4974.4 4976.6 4977.3 4980.9 5013.7 4740.6 4917.7 4952.2 4952.2 4970.6 4889.9 4902.0 4909.8 4959.9 4960.5 4945.3 5004.2 5006.3 5007.2 5048.9 4696.6 4728.8 4763.5 4840.5 4867.9 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | [#1] ext.html Cycles:180 Average:46629.96 Median:19689.03 stddev:79744.23 (405.0%) stddev-sans-first:79892.86 12:30:15 INFO - PROCESS | 25207 | Values: 545.4 584.5 589.1 599.5 608.6 26243.5 38854.8 39692.6 39757.8 39780.6 39518.6 39969.2 40039.8 40052.8 40053.4 7465.2 7573.3 7579.0 7861.0 8022.6 7618.2 10065.1 10339.7 10356.1 10735.0 10436.1 10498.3 10505.2 10507.4 10518.5 7501.0 7689.3 10353.7 10426.7 10428.2 7651.7 10058.6 10401.3 10404.8 10415.3 35856.5 36221.3 36335.6 38932.6 39125.8 2912.2 2977.9 2979.4 3389.3 3448.4 30004.8 30005.7 30629.0 30881.2 31661.0 3532.1 3536.4 3581.9 3583.8 3627.6 264623.0 266483.0 267153.0 267619.0 268002.0 57136.0 57928.7 57993.1 57994.0 57999.7 60107.1 60254.7 60264.1 60439.0 60609.0 14707.3 15140.1 15153.8 15154.2 15162.7 10350.7 11118.5 11336.8 11435.9 11472.3 18448.4 18570.5 18580.8 18600.3 18622.2 6767.9 6949.9 7130.6 7213.6 7220.5 817.4 853.4 872.8 916.9 971.5 27193.3 27979.1 28320.9 28600.1 28635.0 927.6 945.6 1015.6 1054.2 1079.3 14574.9 14988.8 15001.2 15332.6 15355.5 373744.0 375340.0 376037.0 377470.0 378033.0 48480.8 49187.0 49485.3 49566.8 49598.3 1052.8 1116.9 1150.3 1171.9 1187.0 27191.3 29261.3 29577.6 29925.0 30149.4 40129.6 40551.4 40597.0 40636.8 40686.4 253037.0 253681.0 255539.0 255612.0 256529.0 30680.0 37605.6 38825.4 39096.0 41034.4 41136.6 42100.0 42102.0 43105.1 43163.9 36212.6 36412.3 36508.3 36628.8 36709.4 36465.1 36519.3 36623.6 36725.4 36880.0 34944.7 35261.3 35796.1 36056.8 36145.0 30056.8 32959.5 33117.7 33243.3 33277.8 25060.5 25358.7 25642.4 25749.4 25762.5 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | [#2] jquery.html Cycles:180 Average:24075.03 Median:4244.05 stddev:63805.57 (1503.4%) stddev-sans-first:63959.72 12:30:15 INFO - PROCESS | 25207 | Values: 360.6 363.9 380.3 385.3 395.5 16197.4 17117.1 17943.1 17946.2 17948.5 15452.6 16083.8 16480.7 16520.5 16584.3 5152.5 5363.2 5408.6 5411.8 5414.3 3870.7 4016.2 5284.2 5972.7 6297.3 6354.4 6356.5 6388.3 6397.9 6400.1 5323.3 5648.3 5649.0 5722.5 5739.7 3422.2 5143.6 5435.0 5444.3 5473.7 12183.6 12404.3 12411.0 12427.6 12443.2 1969.2 1972.7 2024.7 2222.5 2261.1 8732.1 9050.6 9400.5 9490.2 10259.0 1666.3 1672.7 1745.8 1768.7 1835.0 67883.3 68445.7 69259.3 73128.6 74367.0 9223.7 9572.4 10299.2 10421.7 10533.1 13881.8 13886.3 13942.6 14103.3 14295.0 7161.4 7319.7 7392.7 7452.7 7452.9 7125.1 7161.8 7269.9 7279.7 7394.0 4135.5 4161.3 4204.2 4283.9 4596.2 1705.3 1715.7 1760.6 1816.1 1897.9 755.3 786.8 843.3 866.2 911.4 16750.9 16987.2 17076.1 17709.9 17723.4 840.6 850.7 865.3 886.7 911.2 9543.6 9978.6 9989.9 10049.9 10215.5 380822.0 386259.0 387296.0 388579.0 390083.0 52216.5 63413.7 73465.0 76043.0 77467.6 917.8 936.3 943.1 948.1 951.1 16345.9 16812.2 16892.3 17092.7 17300.3 37336.6 39985.6 40455.4 41500.4 43278.4 51988.2 54827.5 55089.0 55199.2 55240.2 7708.4 7730.3 7763.0 7821.0 7952.1 6501.1 8185.9 9986.7 11981.3 12125.0 10219.3 10485.0 10569.8 10628.1 10733.1 9498.2 9800.3 10455.1 10621.5 10670.8 10465.0 10546.7 10691.2 10735.2 10843.2 7862.6 7998.0 8049.6 8055.6 8370.5 10079.6 10397.9 10647.7 10652.0 10726.2 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | [#3] mootools.html Cycles:180 Average:5178.26 Median:5435.33 stddev:2890.44 (53.2%) stddev-sans-first:2884.21 12:30:15 INFO - PROCESS | 25207 | Values: 1347.9 1410.4 1441.4 1682.6 1694.4 7580.1 7992.2 8018.0 8083.4 8097.0 6850.7 7433.8 7676.0 7702.0 7939.7 2196.5 2207.5 2213.5 2214.4 2225.6 2205.4 2206.7 2250.0 2251.5 2252.8 1861.4 2125.3 2186.2 2195.1 2215.2 2214.0 2218.8 2242.2 2242.7 2257.6 2222.0 2224.1 2224.4 2226.7 2227.0 7991.1 7996.9 8039.7 8041.7 8044.0 4524.3 4568.0 4620.0 4627.9 4632.7 2887.1 2959.8 3015.8 3022.9 3031.9 879.1 889.7 895.4 902.2 912.5 10632.7 10649.8 10685.3 10697.8 10716.6 4050.3 4130.9 4281.7 4285.2 4318.2 9058.0 9114.5 9128.2 9144.9 9146.0 4671.4 4675.0 4682.8 4687.0 4689.5 4059.6 4206.7 4211.3 4212.0 4224.9 3647.8 3699.9 3710.6 3744.2 3749.7 1058.6 1186.1 1187.3 1194.7 1198.1 770.9 801.6 830.2 844.6 861.1 5316.4 5358.6 5393.6 5500.8 5517.0 818.6 831.6 877.5 891.1 892.9 3649.5 3738.9 3743.6 3767.7 3811.2 9522.8 9561.9 9922.7 9949.0 9961.5 9679.5 9681.3 9687.7 9696.5 9722.9 6496.2 7047.4 7324.5 7327.3 7439.8 5355.1 5378.2 5428.2 5519.3 5598.7 8916.8 9110.6 9113.5 9118.5 9127.6 8549.9 9096.3 9106.7 9111.6 9128.4 6731.2 6992.9 7003.5 7027.7 7034.4 7386.0 7468.7 7533.2 7535.0 7586.9 5442.5 6941.8 6944.8 6994.5 7041.9 6607.5 6627.9 6638.2 6646.7 6836.7 6135.6 6145.1 6145.7 6147.1 6152.6 4566.7 4613.1 4647.8 4654.6 4770.3 4483.5 4504.8 4631.8 4645.3 4646.8 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | [#4] prototype.html Cycles:180 Average:4193.79 Median:4593.10 stddev:1213.56 (26.4%) stddev-sans-first:1181.39 12:30:15 INFO - PROCESS | 25207 | Values: 307.6 309.2 314.7 314.8 316.2 4918.3 4931.7 4952.7 4973.3 4986.9 4831.2 4864.3 4929.6 4933.4 4942.8 3623.5 3770.6 3788.4 3796.2 3829.4 3745.5 3813.9 3864.2 3879.3 3907.6 3794.2 3818.9 3827.9 3828.1 3843.1 3725.4 3815.3 3831.0 3832.7 3859.1 3371.8 3384.1 3395.8 3396.9 3410.7 4751.5 4787.5 4817.0 4829.6 4832.0 4157.3 4321.4 4336.3 4336.6 4353.6 5078.4 5085.1 5086.9 5100.7 5103.5 3649.1 3659.6 3666.8 3672.5 3680.2 5210.0 5336.7 5373.5 5403.0 5415.9 3736.9 3746.5 3750.4 3752.3 3769.7 3795.1 3801.8 3806.9 3808.0 3815.9 4105.4 4374.4 4385.2 4385.5 4396.0 5130.3 5130.7 5143.6 5168.9 5197.3 1280.9 1313.3 1314.6 1315.3 1321.9 796.7 830.8 835.1 842.3 847.4 4410.8 4500.6 4539.2 4549.9 4553.7 5263.4 5269.7 5282.9 5305.9 5308.9 4500.6 4523.6 4542.6 4543.6 4556.8 2641.7 2829.6 2830.4 2835.5 2838.2 4978.3 4986.8 5006.2 5010.7 5013.0 5268.7 5387.2 5423.8 5424.2 5432.4 4966.8 4975.3 4979.0 4991.4 5012.6 5310.9 5312.0 5317.3 5330.6 5333.0 4978.0 5184.7 5192.0 5212.6 5248.7 4952.9 4958.4 4963.0 4965.7 4978.3 3325.0 3387.0 3443.3 3462.7 3473.0 4530.0 4704.5 4776.9 4791.4 4801.2 4568.3 4573.9 4586.3 4602.9 4607.0 4576.5 4591.8 4643.1 4651.7 4674.6 4312.8 4516.5 4521.3 4524.0 4528.6 4594.4 4862.5 5000.4 5162.2 5186.5 5026.4 5036.4 5037.8 5065.1 5090.8 12:30:15 INFO - PROCESS | 25207 | 12:30:15 INFO - PROCESS | 25207 | [#5] yui.html Cycles:180 Average:18614.14 Median:4184.78 stddev:27183.77 (649.6%) stddev-sans-first:27226.58 12:30:15 INFO - PROCESS | 25207 | Values: 653.1 660.0 692.2 695.4 749.0 12703.8 13126.1 13142.8 13241.3 13251.6 12739.7 13369.4 13418.7 13455.4 13469.2 624.6 772.6 782.1 785.1 785.4 764.4 792.8 793.9 794.2 795.7 827.6 828.8 830.5 830.8 831.3 652.1 802.3 824.9 825.2 825.5 603.1 606.0 606.4 606.7 606.7 13453.7 13459.6 13575.8 13586.3 13616.9 12862.9 13386.4 13395.7 13444.5 13520.2 11625.8 11642.6 11704.4 11870.6 12145.9 4145.9 4223.6 4267.6 4337.8 4344.6 65169.3 65882.7 65923.0 66188.0 66587.3 10334.1 10666.5 10686.5 10690.7 10725.1 19882.7 19884.7 19890.9 19894.3 19912.3 6500.7 6732.8 6801.7 6858.6 6870.6 3554.4 3643.4 3713.3 3719.9 3725.7 2945.4 3071.7 3073.2 3074.9 3077.0 504.7 505.6 514.5 517.6 524.8 534.0 538.5 539.5 557.6 559.4 7220.9 7243.9 7493.8 7504.2 7665.9 444.4 493.9 512.9 547.6 548.9 3668.5 3698.0 3717.1 3722.4 3823.4 104711.8 106380.0 107846.0 108832.0 109411.0 91839.5 94228.5 95196.0 95813.0 96152.0 47263.3 47488.0 80560.0 81835.6 82477.6 7150.0 7190.2 7277.8 7348.9 7411.7 45872.3 47247.0 47412.3 48961.5 49009.5 60602.7 62735.0 64813.0 69898.0 70774.3 11181.7 11562.2 11609.7 11863.6 12405.3 12452.8 12948.3 13323.0 13435.9 13602.4 11987.7 12079.7 12243.6 12449.1 12843.7 12198.9 12324.2 12408.4 12910.7 13214.8 11367.8 12308.8 12392.3 12419.6 12450.9 10300.6 10415.9 10511.8 10683.1 10758.5 10003.6 10407.4 10434.1 10616.8 10628.2 12:30:15 INFO - PROCESS | 25207 | -------- Summary: end -------- 12:30:15 INFO - PROCESS | 25207 | 12:30:16 INFO - TEST-INFO | 25207: exit 0 12:30:16 INFO - TEST-OK | dromaeo_css | took 1120544ms 12:30:16 INFO - TEST-START | kraken 12:30:16 INFO - operating with platform_type : linux_ 12:30:16 INFO - Initialising browser for kraken test... 12:30:16 INFO - TEST-INFO | started process 25408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ClkE8/profile http://localhost:56871/getInfo.html) 12:30:20 INFO - PROCESS | 25408 | __metrics Screen width/height:1600/1200 12:30:20 INFO - PROCESS | 25408 | colorDepth:24 12:30:20 INFO - PROCESS | 25408 | Browser inner width/height: 1024/697 12:30:20 INFO - PROCESS | 25408 | __metrics 12:30:21 INFO - PROCESS | 25408 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:30:22 INFO - TEST-INFO | 25408: exit 0 12:30:22 INFO - Browser initialized. 12:30:22 INFO - Running cycle 1/1 for kraken test... 12:30:22 INFO - TEST-INFO | started process 25488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ClkE8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:30:34 INFO - PROCESS | 25488 | RSS: Main: 158515200 12:30:34 INFO - PROCESS | 25488 | 12:30:37 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56871/tests/kraken/driver.html?testName=audio-beat-detection) 12:30:38 INFO - PROCESS | 25488 | RSS: Main: 216817664 12:30:38 INFO - PROCESS | 25488 | 12:30:40 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56871/tests/kraken/driver.html?testName=audio-dft) 12:30:41 INFO - PROCESS | 25488 | RSS: Main: 204369920 12:30:41 INFO - PROCESS | 25488 | 12:30:44 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56871/tests/kraken/driver.html?testName=audio-fft) 12:30:45 INFO - PROCESS | 25488 | RSS: Main: 271114240 12:30:45 INFO - PROCESS | 25488 | 12:30:47 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56871/tests/kraken/driver.html?testName=audio-oscillator) 12:30:48 INFO - PROCESS | 25488 | RSS: Main: 181559296 12:30:48 INFO - PROCESS | 25488 | 12:30:50 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:30:51 INFO - PROCESS | 25488 | RSS: Main: 185966592 12:30:51 INFO - PROCESS | 25488 | 12:30:54 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56871/tests/kraken/driver.html?testName=imaging-darkroom) 12:30:54 INFO - PROCESS | 25488 | RSS: Main: 221544448 12:30:54 INFO - PROCESS | 25488 | 12:30:58 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56871/tests/kraken/driver.html?testName=imaging-desaturate) 12:30:59 INFO - PROCESS | 25488 | RSS: Main: 217460736 12:30:59 INFO - PROCESS | 25488 | 12:31:01 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56871/tests/kraken/driver.html?testName=json-parse-financial) 12:31:02 INFO - PROCESS | 25488 | RSS: Main: 220614656 12:31:02 INFO - PROCESS | 25488 | 12:31:04 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:31:04 INFO - PROCESS | 25488 | RSS: Main: 208343040 12:31:04 INFO - PROCESS | 25488 | 12:31:06 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:31:07 INFO - PROCESS | 25488 | RSS: Main: 211640320 12:31:07 INFO - PROCESS | 25488 | 12:31:09 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:31:10 INFO - PROCESS | 25488 | RSS: Main: 208969728 12:31:10 INFO - PROCESS | 25488 | 12:31:12 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:31:13 INFO - PROCESS | 25488 | RSS: Main: 223371264 12:31:13 INFO - PROCESS | 25488 | 12:31:16 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:31:16 INFO - PROCESS | 25488 | RSS: Main: 224296960 12:31:16 INFO - PROCESS | 25488 | 12:31:18 INFO - PROCESS | 25488 | Cycle 1(1): loaded http://localhost:56871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56871/tests/kraken/driver.html?testName=ai-astar) 12:31:19 INFO - PROCESS | 25488 | RSS: Main: 266555392 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | __start_tp_report 12:31:19 INFO - PROCESS | 25488 | _x_x_mozilla_page_load 12:31:19 INFO - PROCESS | 25488 | _x_x_mozilla_page_load_details 12:31:19 INFO - PROCESS | 25488 | |i|pagename|runs| 12:31:19 INFO - PROCESS | 25488 | |0;ai-astar;101;114;111;112;112;112;112;112;111;115 12:31:19 INFO - PROCESS | 25488 | |1;audio-beat-detection;150;123;122;180;128;127;143;121;178;121 12:31:19 INFO - PROCESS | 25488 | |2;audio-dft;161;161;162;161;162;161;160;160;161;161 12:31:19 INFO - PROCESS | 25488 | |3;audio-fft;76;76;77;107;77;77;75;75;99;76 12:31:19 INFO - PROCESS | 25488 | |4;audio-oscillator;85;86;109;85;87;85;115;85;85;132 12:31:19 INFO - PROCESS | 25488 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;116 12:31:19 INFO - PROCESS | 25488 | |6;imaging-darkroom;146;147;146;146;145;147;146;145;146;146 12:31:19 INFO - PROCESS | 25488 | |7;imaging-desaturate;95;95;94;94;94;94;96;94;96;95 12:31:19 INFO - PROCESS | 25488 | |8;json-parse-financial;62;63;63;64;63;64;64;63;62;64 12:31:19 INFO - PROCESS | 25488 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;63;64;64 12:31:19 INFO - PROCESS | 25488 | |10;stanford-crypto-aes;85;78;78;79;78;81;86;78;78;78 12:31:19 INFO - PROCESS | 25488 | |11;stanford-crypto-ccm;130;135;126;127;128;129;130;137;172;130 12:31:19 INFO - PROCESS | 25488 | |12;stanford-crypto-pbkdf2;176;170;170;171;168;166;165;168;171;166 12:31:19 INFO - PROCESS | 25488 | |13;stanford-crypto-sha256-iterative;68;67;69;66;68;71;68;70;67;67 12:31:19 INFO - PROCESS | 25488 | __end_tp_report 12:31:19 INFO - PROCESS | 25488 | __start_cc_report 12:31:19 INFO - PROCESS | 25488 | _x_x_mozilla_cycle_collect,1935 12:31:19 INFO - PROCESS | 25488 | __end_cc_report 12:31:19 INFO - PROCESS | 25488 | __startTimestamp1467660679003__endTimestamp 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | ------- Summary: start ------- 12:31:19 INFO - PROCESS | 25488 | Number of tests: 14 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.79 (3.4%) stddev-sans-first:1.32 12:31:19 INFO - PROCESS | 25488 | Values: 101.0 114.0 111.0 112.0 112.0 112.0 112.0 112.0 111.0 115.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:135.50 stddev:23.08 (17.0%) stddev-sans-first:24.16 12:31:19 INFO - PROCESS | 25488 | Values: 150.0 123.0 122.0 180.0 128.0 127.0 143.0 121.0 178.0 121.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 12:31:19 INFO - PROCESS | 25488 | Values: 161.0 161.0 162.0 161.0 162.0 161.0 160.0 160.0 161.0 161.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:11.51 (15.0%) stddev-sans-first:12.04 12:31:19 INFO - PROCESS | 25488 | Values: 76.0 76.0 77.0 107.0 77.0 77.0 75.0 75.0 99.0 76.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:17.02 (20.0%) stddev-sans-first:17.64 12:31:19 INFO - PROCESS | 25488 | Values: 85.0 86.0 109.0 85.0 87.0 85.0 115.0 85.0 85.0 132.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:31:19 INFO - PROCESS | 25488 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:31:19 INFO - PROCESS | 25488 | Values: 146.0 147.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 146.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 12:31:19 INFO - PROCESS | 25488 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 96.0 94.0 96.0 95.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 12:31:19 INFO - PROCESS | 25488 | Values: 62.0 63.0 63.0 64.0 63.0 64.0 64.0 63.0 62.0 64.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 12:31:19 INFO - PROCESS | 25488 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:78.50 stddev:3.11 (4.0%) stddev-sans-first:2.69 12:31:19 INFO - PROCESS | 25488 | Values: 85.0 78.0 78.0 79.0 78.0 81.0 86.0 78.0 78.0 78.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:130.00 stddev:13.64 (10.5%) stddev-sans-first:14.37 12:31:19 INFO - PROCESS | 25488 | Values: 130.0 135.0 126.0 127.0 128.0 129.0 130.0 137.0 172.0 130.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:170.00 stddev:3.25 (1.9%) stddev-sans-first:2.29 12:31:19 INFO - PROCESS | 25488 | Values: 176.0 170.0 170.0 171.0 168.0 166.0 165.0 168.0 171.0 166.0 12:31:19 INFO - PROCESS | 25488 | 12:31:19 INFO - PROCESS | 25488 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.62 12:31:19 INFO - PROCESS | 25488 | Values: 68.0 67.0 69.0 66.0 68.0 71.0 68.0 70.0 67.0 67.0 12:31:19 INFO - PROCESS | 25488 | -------- Summary: end -------- 12:31:19 INFO - PROCESS | 25488 | 12:31:20 INFO - TEST-INFO | 25488: exit 0 12:31:20 INFO - TEST-OK | kraken | took 63586ms 12:31:20 INFO - SUITE-END | took 1184s 12:31:20 INFO - Completed test suite (00:19:44) 12:31:20 INFO - javascript benchmark 12:31:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.2702443315866, 2620.92137235883, 2640.894364225431, 2644.272824973132, 2648.920532384028, 4590.540945905408, 4638.188317044513, 4674.228752255878, 4705.670603057787, 4720.881977950553, 4664.720116792986, 4700.0, 4711.740854253023, 4727.196376615975, 4746.145693775119, 4326.502452218004, 4329.437173167499, 4366.170427618758, 4375.234333991555, 4395.978020109895, 4356.89107772305, 4425.601695847373, 4456.554344565534, 4464.3303504474425, 4496.752678602676, 4404.0, 4444.644428445733, 4461.973746038429, 4462.97768511157, 4498.055408364247, 4242.172776308621, 4265.0, 4287.3140297552245, 4292.0772034012525, 4331.891702707458, 4275.0, 4297.806598703066, 4347.717398369127, 4352.804123814436, 4419.867403977853, 4784.928226076611, 4787.736674482902, 4794.376731024944, 4801.567858892681, 4808.903821923542, 4913.115639184945, 4987.376577927759, 5060.696358218519, 5073.873153171164, 5153.407358153823, 5107.668001579886, 5149.48505149482, 5151.330327057496, 5167.948320516822, 5171.560417364529, 4602.493725690171, 4786.3777708898315, 4812.759362031885, 4830.975845120752, 4832.9275060874115, 5116.232565115188, 5148.176291793295, 5202.7918883245, 5278.419373868871, 5298.761555730001, 5060.0, 5073.492650734971, 5074.314967479417, 5075.695458272516, 5081.110805609003, 4938.407391113089, 5097.311862898461, 5115.590752739847, 5142.357205349332, 5159.380874295033, 4993.425756038102, 5031.748412579356, 5049.545540901337, 5071.8985620287385, 5082.0, 5052.141136006888, 5053.0651829410945, 5056.0140772549, 5062.645614807002, 5112.36095488064, 4169.874903752892, 4196.118815048813, 4332.631726303236, 4356.782160891943, 4397.384366188736, 3707.35121353762, 3733.290674771785, 3739.7943113128495, 3775.0, 3785.1483416231677, 4321.330193819963, 4323.546027667113, 4337.262665346899, 4338.652907767371, 4386.013147041954, 4957.727324997088, 5001.224810154432, 5003.074431230234, 5017.12200364942, 5040.747962601855, 4318.114786468766, 4354.586314300136, 4364.323529852878, 4364.367166760802, 4373.934390984138, 4572.611328037154, 4574.519675434098, 4590.655700822452, 4597.241455159928, 4613.5847773700525, 4655.0, 4743.83396581118, 4771.6898401603785, 4786.593139583175, 4787.281907713871, 5068.0, 5104.489551044866, 5128.230765385222, 5128.871778205575, 5175.171972484384, 4803.8318658848175, 4808.495108013748, 4812.735299558558, 4818.10864989978, 4856.854294371175, 4842.83050093245, 4960.627952903619, 4964.081644895706, 4987.152184128634, 5096.413912399973, 5082.085224659597, 5104.9744751276, 5114.258432527188, 5119.692818430906, 5159.974200129125, 4974.353334066548, 4976.576990955665, 4977.328060711902, 4980.900381992412, 5013.674111182761, 4740.6207503398955, 4917.655764096479, 4952.207646776498, 4952.207646776498, 4970.6023518117745, 4889.926651100165, 4901.950980490292, 4909.828156014522, 4959.9008019838675, 4960.528749768766, 4945.307656927961, 5004.174311238605, 5006.299118123393, 5007.198848184273, 5048.873778155576, 4696.624270058319, 4728.810847566197, 4763.476017637988, 4840.515948405131, 4867.926981095357], "value": 4659.369450241279, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.3797077587981, 584.541135208861, 589.051626880722, 599.5353600959257, 608.5861614102408, 26243.4751304974, 38854.80572597137, 39692.60307396925, 39757.8012109939, 39780.602193978055, 39518.60481395185, 39969.20061598766, 40039.799801000954, 40052.799736001354, 40053.39919901204, 7465.178830328659, 7573.318401343878, 7579.0, 7861.0, 8022.598870056503, 7618.200088990659, 10065.144462720678, 10339.689809305733, 10356.119729822974, 10735.033846953773, 10436.06075453209, 10498.317609355405, 10505.21210909181, 10507.369557826516, 10518.474076296194, 7500.962495187544, 7689.307962283366, 10353.689389318295, 10426.73933151666, 10428.165746740318, 7651.732189373345, 10058.597656093747, 10401.271910966236, 10404.843927341097, 10415.323004004715, 35856.462153067725, 36221.27557448862, 36335.636643633756, 38932.610673893185, 39125.80437097825, 2912.155474912273, 2977.895773647912, 2979.4190132924086, 3389.3405240518678, 3448.3965306071586, 30004.8499757502, 30005.699943000727, 30629.0, 30881.227969300722, 31661.0, 3532.0993146747674, 3536.398812201932, 3581.946270805914, 3583.8387272572795, 3627.5646922369483, 264623.0, 266483.0, 267153.0, 267619.0, 268002.0, 57136.0, 57928.71035644795, 57993.13010304849, 57994.0, 57999.71000144972, 60107.09839352413, 60254.69872650609, 60264.09603855946, 60439.0, 60609.0, 14707.264636768119, 15140.091594504365, 15153.848461515243, 15154.16652084146, 15162.696746065018, 10350.741231469274, 11118.499667514981, 11336.773264534828, 11435.94282028601, 11472.31166130035, 18448.446546603624, 18570.535736606424, 18580.81419185818, 18600.255989760528, 18622.16200270991, 6767.893711602797, 6949.861002779916, 7130.607816570035, 7213.6195055631515, 7220.530665506725, 817.3951276055676, 853.3727710133047, 872.7992561710842, 916.862470629411, 971.5433746139303, 27193.32016699598, 27979.135083379893, 28320.858395707888, 28600.14199574016, 28635.0, 927.6474939522938, 945.6075728572703, 1015.5937624950079, 1054.1619412567027, 1079.3469950679882, 14574.927125364517, 14988.775168372484, 15001.2499375033, 15332.616684582752, 15355.462558810388, 373744.0, 375340.0, 376037.0, 377470.0, 378033.0, 48480.787980300775, 49187.0, 49485.257721134214, 49566.75216623966, 49598.25602615964, 1052.7894421115807, 1116.9497372618089, 1150.327058670687, 1171.8945294923499, 1186.9821952670716, 27191.320216994733, 29261.268468288465, 29577.556336654536, 29925.0, 30149.397012060075, 40129.598704012584, 40551.391729124676, 40597.0, 40636.79681601573, 40686.389704153866, 253037.0, 253681.0, 255539.0, 255612.0, 256529.0, 30680.0, 37605.62394376021, 38825.41761873518, 39096.0, 41034.38448423336, 41136.58863411328, 42100.0, 42102.0, 43105.13789724251, 43163.920901977704, 36212.63787362093, 36412.27175456423, 36508.26983460369, 36628.816855916615, 36709.44935826018, 36465.07831436198, 36519.26961460809, 36623.63376366202, 36725.44911826271, 36880.0, 34944.65055349516, 35261.294774104885, 35796.105097372776, 36056.819715901256, 36145.0, 30056.849715751283, 32959.50560741639, 33117.66882331146, 33243.335133296714, 33277.83361083179, 25060.498790023732, 25358.74641253564, 25642.358941026625, 25749.3562660935, 25762.484750305262], "value": 18232.816014600307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.5889286213716, 363.89628955747617, 380.34200832559674, 385.3026022898552, 395.4858683711175, 16197.433089841843, 17117.14414279286, 17943.10284485777, 17946.192421341053, 17948.461546153605, 15452.613684657888, 16083.758743618826, 16480.67038659229, 16520.504384868473, 16584.336626534925, 5152.484751524837, 5363.249145119687, 5408.648437851547, 5411.756470958816, 5414.269073675063, 3870.748401353917, 4016.236914986158, 5284.154535274357, 5972.701364931758, 6297.3387794281625, 6354.364563543631, 6356.523260755462, 6388.297287298416, 6397.904031439532, 6400.071989561534, 5323.334583177103, 5648.293963254593, 5649.0396632572565, 5722.54219662426, 5739.684317362543, 3422.178677117499, 5143.588512918957, 5435.0, 5444.292242008513, 5473.698946557938, 12183.634490965285, 12404.317762523058, 12411.0, 12427.565035223814, 12443.191192572454, 1969.2221572478934, 1972.6646470100118, 2024.6760518316999, 2222.511047569532, 2261.0842608743487, 8732.083131271189, 9050.592723327467, 9400.482973436458, 9490.240780737524, 10259.0, 1666.3334666133521, 1672.6989141954443, 1745.8428741413206, 1768.6674675852316, 1835.0366057819617, 67883.3211667887, 68445.65777171082, 69259.30740692579, 73128.63435682788, 74366.99999999946, 9223.650436656231, 9572.377795443273, 10299.227557933034, 10421.68734937953, 10533.104686101768, 13881.791773123412, 13886.305684715926, 13942.58172254834, 14103.2948352584, 14294.999350045397, 7161.355478007004, 7319.707211711579, 7392.741254056083, 7452.739154129579, 7452.925470745223, 7125.073740413713, 7161.785146445615, 7269.89095163573, 7279.708811647475, 7393.963030184815, 4135.462389889355, 4161.25097482456, 4204.180184863983, 4283.914321713611, 4596.17268891596, 1705.3178728508449, 1715.6654452381665, 1760.5686606781164, 1816.1373347659755, 1897.8671492995634, 755.3051192902543, 786.7679034684782, 843.2537204573873, 866.2030931542996, 911.444019148319, 16750.916245418695, 16987.150642467826, 17076.146192690565, 17709.911450442924, 17723.379681711078, 840.6175190288404, 850.7150104714866, 865.34233982174, 886.6674996876171, 911.2345629671108, 9543.570539325747, 9978.600855965826, 9989.850152247722, 10049.949750251202, 10215.489225538693, 380822.0, 386259.0, 387296.0, 388579.0, 390083.0, 52216.47783522116, 63413.68293158505, 73465.0, 76043.0, 77467.61266193633, 917.7980844214262, 936.3398803843274, 943.118184497497, 948.0993056596261, 951.07270411347, 16345.918270408572, 16812.24344904507, 16892.324307027582, 17092.743608845627, 17300.307987680353, 37336.626633733315, 39985.600143998185, 40455.393169103074, 41500.37749433701, 43278.35082473703, 51988.22017669814, 54827.451725482235, 55089.0, 55199.17201241904, 55240.17139742827, 7708.421868359784, 7730.265624765639, 7762.961185194038, 7820.960895195488, 7952.085510166405, 6501.08984742127, 8185.8772118419465, 9986.700398988041, 11981.28112313264, 12124.964424982561, 10219.25359421963, 10485.0, 10569.788604227719, 10628.096611788085, 10733.141348692243, 9498.24014078886, 9800.264980126662, 10455.111315538265, 10621.522031508446, 10670.786584268426, 10465.0, 10546.683599492027, 10691.198160138176, 10735.248532602955, 10843.240973131806, 7862.60686965638, 7998.040235171584, 8049.557274349967, 8055.637496312797, 8370.53962032094, 10079.596816127567, 10397.896021039995, 10647.733806654896, 10652.041316281262, 10726.249162558546], "value": 8189.402004591126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.8786909178175, 1410.42877634558, 1441.3657990484187, 1682.5625337412268, 1694.390019592947, 7580.090389153303, 7992.200779922005, 8018.0, 8083.4341596088225, 8096.95951520243, 6850.69171887265, 7433.776986690395, 7675.961620191905, 7702.0, 7939.722109726161, 2196.494806194572, 2207.514346843692, 2213.513027134028, 2214.3910424633273, 2225.610518159324, 2205.4376134085787, 2206.702095217141, 2250.0212407602744, 2251.4596496840804, 2252.8197744180425, 1861.3671351740406, 2125.319897632758, 2186.158329043322, 2195.121951219509, 2215.191455118878, 2214.047959377467, 2218.7559368469456, 2242.2040175737543, 2242.730872295335, 2257.593633146033, 2221.9888900555393, 2224.143704673696, 2224.354937068248, 2226.699395581592, 2227.008981003454, 7991.120976692559, 7996.920030799675, 8039.718609848685, 8041.718539851077, 8043.95978020112, 4524.276115821453, 4567.977160114178, 4619.95380046202, 4627.8611641650805, 4632.745199014053, 2887.076135636597, 2959.8076125051803, 3015.834129122897, 3022.9244268893235, 3031.9090427287215, 879.134052957836, 889.6841621224437, 895.417978314101, 902.1835239108617, 912.5300470257822, 10632.681019569425, 10649.78700425995, 10685.252032357737, 10697.786044279072, 10716.571337146504, 4050.270951228807, 4130.91738165235, 4281.7002809803635, 4285.207236661166, 4318.201132790444, 9057.954710226406, 9114.544272786334, 9128.224100951493, 9144.908550914539, 9146.0, 4671.43942726875, 4674.95325046752, 4682.789274482657, 4686.95313046872, 4689.50760170184, 4059.5534491205945, 4206.663466922639, 4211.263028969979, 4211.978940105279, 4224.936625950613, 3647.8176091195332, 3699.9445008324897, 3710.6474884885893, 3744.1762812181278, 3749.6625303722794, 1058.6136060337922, 1186.0630102219322, 1187.2757617853104, 1194.6893807610084, 1198.1433275208267, 770.8689522781141, 801.6072124658875, 830.1781236575868, 844.5566077809076, 861.1001503428931, 5316.441773613715, 5358.571314294847, 5393.568514518829, 5500.834974950758, 5517.0, 818.5825229133185, 831.6236628380041, 877.5217506458995, 891.1133422244908, 892.9330300227509, 3649.4708267301626, 3738.9439158412647, 3743.644353786386, 3767.6609105180664, 3811.1805961718364, 9522.809543809086, 9561.9043809561, 9922.652707155215, 9949.005099489994, 9961.452120133317, 9679.467629280458, 9681.322307438411, 9687.70936871895, 9696.51517424126, 9722.854157187649, 6496.155499784998, 7047.43620510358, 7324.498477812036, 7327.340539351484, 7439.8140046499275, 5355.116405793001, 5378.1663842104535, 5428.158635411518, 5519.337679478488, 5598.720063996702, 8916.821663566821, 9110.590023449093, 9113.453192808453, 9118.544072796201, 9127.634894604142, 8549.871751923602, 9096.272298215994, 9106.726798196065, 9111.589978451118, 9128.406653567497, 6731.225909020525, 6992.895106573304, 7003.509754317352, 7027.683754231174, 7034.437245020488, 7386.0, 7468.738594149178, 7533.209013053551, 7535.020447341811, 7586.924130758843, 5442.499697587199, 6941.826454338682, 6944.791656250321, 6994.545354551938, 7041.929580704127, 6607.537472376887, 6627.900581491378, 6638.17022872141, 6646.700898459678, 6836.692348844414, 6135.570510064431, 6145.13968044483, 6145.6927153641245, 6147.108669243024, 6152.600080994721, 4566.725996440225, 4613.146567884952, 4647.767611619338, 4654.581087702123, 4770.260609605517, 4483.461984561874, 4504.77476126199, 4631.791569379318, 4645.3032045193495, 4646.83736069236], "value": 4170.853360997756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.5755457468693, 309.18067122126365, 314.70417807261174, 314.7717904519223, 316.1747838142449, 4918.3114363989025, 4931.728754918478, 4952.678075925067, 4973.328600638913, 4986.875328116799, 4831.227003679412, 4864.348929833241, 4929.556339929406, 4933.432655244648, 4942.777575009124, 3623.456481527772, 3770.5852356240794, 3788.4317352397225, 3796.2027974125467, 3829.4064420014943, 3745.5392396965203, 3813.8665146719873, 3864.188520410717, 3879.2823327684328, 3907.628775266345, 3794.2221844521805, 3818.9045273868237, 3827.942580861289, 3828.0812604974885, 3843.077661361281, 3725.4411838224214, 3815.275097731422, 3831.0, 3832.693384529245, 3859.073822282646, 3371.8482668279985, 3384.13704505352, 3395.7792743471596, 3396.8980930572125, 3410.693037626601, 4751.477337492873, 4787.473377928425, 4816.975915120437, 4829.589484893788, 4831.95168048322, 4157.3185295484245, 4321.37340085689, 4336.3278691802825, 4336.56634336567, 4353.586409291112, 5078.4413714491375, 5085.059264036166, 5086.872828179288, 5100.719460429675, 5103.540681338697, 3649.1059690375764, 3659.6157403472516, 3666.8349924253207, 3672.540932383452, 3680.2271522980204, 5209.973950130225, 5336.733163341856, 5373.468561460004, 5402.972985135049, 5415.864603384907, 3736.850525978985, 3746.5316835395574, 3750.3811871041516, 3752.2870654575545, 3769.679577235911, 3795.1081495848453, 3801.790901500389, 3806.8667596633986, 3808.0, 3815.893390916603, 4105.404716316118, 4374.431323927869, 4385.232584297735, 4385.451818522684, 4396.0, 5130.333056702605, 5130.691673623202, 5143.639945203875, 5168.870778230575, 5197.29836472079, 1280.8975281977418, 1313.3105119812176, 1314.5859054397833, 1315.2963164706837, 1321.914075585084, 796.6733639208013, 830.8047608811925, 835.1022650650453, 842.2503971465401, 847.3771777743353, 4410.823567057282, 4500.639948804088, 4539.228331183706, 4549.909001819945, 4553.658475614276, 5263.421023687391, 5269.736513174326, 5282.894342113136, 5305.946940530545, 5308.946910530923, 4500.617447516997, 4523.615492683093, 4542.613877820422, 4543.5910768031035, 4556.794944227518, 2641.6697912760906, 2829.627630599158, 2830.4056148208697, 2835.4754370441533, 2838.155199120547, 4978.316046125841, 4986.775595098229, 5006.199008158677, 5010.749462526859, 5012.974935125374, 5268.6575372600655, 5387.24578559002, 5423.83728488146, 5424.186372044146, 5432.414606359863, 4966.8261610844165, 4975.333263356743, 4978.950210497921, 4991.376077990251, 5012.649114562018, 5310.920336194883, 5311.973440132774, 5317.308749862493, 5330.600204984564, 5332.986732520809, 4977.9751101244265, 5184.688918664892, 5192.0, 5212.609054321017, 5248.6588371755715, 4952.851414457572, 4958.355413796184, 4962.975185124195, 4965.677230979974, 4978.32792572998, 3324.9501257480674, 3387.000834753803, 3443.27691184854, 3462.688358047788, 3472.9652703472643, 4530.0, 4704.482506924167, 4776.880577985578, 4791.425028996543, 4801.207800712983, 4568.337591049346, 4573.908521829611, 4586.312053192048, 4602.930956035595, 4606.953930460652, 4576.542345765397, 4591.783177458043, 4643.0516621944635, 4651.651126165619, 4674.649401294849, 4312.827486900489, 4516.525764794649, 4521.276595744665, 4524.0, 4528.622473201595, 4594.425696787902, 4862.513748625251, 5000.424951130666, 5162.199859021857, 5186.533212010937, 5026.421961474477, 5036.420811606566, 5037.7733002014265, 5065.138926382598, 5090.796368145233], "value": 3810.8738617572812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.0824192010227, 659.9802005939822, 692.162483395092, 695.3845846425914, 748.9550626962383, 12703.809442858354, 13126.081174317802, 13142.802857957138, 13241.271730054843, 13251.602451926457, 12739.745205095893, 13369.39837707303, 13418.664533386645, 13455.394507247172, 13469.191848489098, 624.6377101281246, 772.5750837039619, 782.0654318089885, 785.1128225105623, 785.3795501553766, 764.4457768118125, 792.7582087463321, 793.896793416855, 794.2494342846013, 795.7334293011847, 827.5986146718836, 828.7679449754079, 830.485099238473, 830.767385132164, 831.2726364431123, 652.1424327009967, 802.3100133884855, 824.9051359093721, 825.22428916818, 825.5376988886243, 603.1074010464494, 605.9818205453844, 606.4238972975646, 606.6572386601556, 606.6875559087074, 13453.66365840852, 13459.596212113653, 13575.796363054464, 13586.320683965861, 13616.93191534046, 12862.935685321607, 13386.39761210748, 13395.665108372272, 13444.467638843356, 13520.18878867271, 11625.825612615818, 11642.59250926222, 11704.356260405675, 11870.643880683594, 12145.939270303681, 4145.937810932838, 4223.619874211336, 4267.551907049746, 4337.761423121727, 4344.63070638996, 65169.34830651728, 65882.67058664723, 65923.0, 66188.0, 66587.33412665859, 10334.121599663962, 10666.520006599721, 10686.465676716132, 10690.679279621623, 10725.14198864089, 19882.70175947362, 19884.70172947407, 19890.90054549747, 19894.30369937045, 19912.303069392503, 6500.739970401226, 6732.798016059526, 6801.727930882709, 6858.588484690935, 6870.553414028072, 3554.360215161244, 3643.4352675335367, 3713.2573485303046, 3719.907002324909, 3725.70194384454, 2945.4403663303906, 3071.6774738652566, 3073.1548824073557, 3074.8923787667322, 3077.046115704139, 504.7097918696764, 505.56268827464714, 514.4675261104738, 517.6014468858957, 524.8005757812083, 533.9866503337448, 538.488435985815, 539.5252178083261, 557.6152454806171, 559.4014404587052, 7220.927790722026, 7243.89134162988, 7493.775186744407, 7504.249575042452, 7665.946064415913, 444.4133743458668, 493.9306401640408, 512.8974205158983, 547.6248769592842, 548.8929658716512, 3668.523091998023, 3698.0, 3717.1078941054493, 3722.4230244312175, 3823.388257878726, 104711.76441178063, 106380.0, 107846.0, 108832.0, 109411.0, 91839.54080229557, 94228.52885735527, 95196.0, 95813.0, 96152.0, 47263.29105063427, 47488.0, 80560.0, 81835.5908220467, 82477.58761206156, 7150.0, 7190.20907700163, 7277.781666550012, 7348.853022939618, 7411.66647500853, 45872.31191532197, 47247.0, 47412.2888156671, 48961.51038489569, 49009.50990490192, 60602.696986514784, 62735.0, 64813.0, 69898.0, 70774.29225707677, 11181.72045698864, 11562.19064665499, 11609.709757256136, 11863.644090677293, 12405.255684658949, 12452.750944981231, 12948.28784416866, 13323.000774941724, 13435.865641343462, 13602.38789254466, 11987.700307492383, 12079.698007549881, 12243.632691018927, 12449.066320025853, 12843.743125137631, 12198.878011219775, 12324.198927069712, 12408.441620127296, 12910.741785164431, 13214.801777973145, 11367.772644547229, 12308.753824923273, 12392.31842248685, 12419.627411177678, 12450.937745311578, 10300.639477618248, 10415.895841041493, 10511.78976420452, 10683.145348372267, 10758.46207689628, 10003.649872254437, 10407.427591482541, 10434.141211767559, 10616.787664246518, 10628.202884783517], "value": 6697.568249679912, "unit": "score"}], "name": "dromaeo_css", "value": 6480.498815242883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 115.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 122.0, 180.0, 128.0, 127.0, 143.0, 121.0, 178.0, 121.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 160.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 107.0, 77.0, 77.0, 75.0, 75.0, 99.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 109.0, 85.0, 87.0, 85.0, 115.0, 85.0, 85.0, 132.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 96.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 63.0, 62.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 78.0, 79.0, 78.0, 81.0, 86.0, 78.0, 78.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 126.0, 127.0, 128.0, 129.0, 130.0, 137.0, 172.0, 130.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 170.0, 171.0, 168.0, 166.0, 165.0, 168.0, 171.0, 166.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 66.0, 68.0, 71.0, 68.0, 70.0, 67.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1524.5, "alertThreshold": 2.0}]} 12:31:20 INFO - Return code: 0 12:31:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:31:20 INFO - # TBPL SUCCESS # 12:31:20 INFO - Running post-action listener: _resource_record_post_action 12:31:20 INFO - ##### 12:31:20 INFO - ##### Finished run-tests step (success) 12:31:20 INFO - ##### 12:31:20 INFO - Running post-run listener: _resource_record_post_run 12:31:20 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535416832; Read time: 12; Write time: 405528 12:31:20 INFO - TinderboxPrint: CPU usage
13.0% 12:31:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:31:20 INFO - TinderboxPrint: I/O write bytes / time
535,416,832 / 405,528 12:31:20 INFO - TinderboxPrint: CPU idle
8,338.6 (87.0%) 12:31:20 INFO - TinderboxPrint: CPU user
1,204.0 (12.6%) 12:31:20 INFO - TinderboxPrint: Swap in / out
0 / 0 12:31:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246202368; Read time: 0; Write time: 223900 12:31:20 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 289214464; Read time: 0; Write time: 181628 12:31:20 INFO - Running post-run listener: _upload_blobber_files 12:31:20 INFO - Blob upload gear active. 12:31:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:31:20 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 12:31:20 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'] 12:31:20 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 12:31:21 INFO - (blobuploader) - INFO - Open directory for files ... 12:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:22 INFO - (blobuploader) - INFO - Done attempting. 12:31:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:31:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:25 INFO - (blobuploader) - INFO - Done attempting. 12:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:26 INFO - (blobuploader) - INFO - Done attempting. 12:31:26 INFO - (blobuploader) - INFO - Iteration through files over. 12:31:26 INFO - Return code: 0 12:31:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:31:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:31:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caa062afb935e8578de2b4244e9f0a08374b36e91fbaaf34f95c86adc68f3d733f83fc9a683acaea6255d9bf64d051d01f70f456ad22eda047454baa0a9213ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96f92747737f1dc3acafa8a162cef25a081bf0d6d49d40b92a7c3e4269c4de5f452f7cdd09552203363e10ceca9e20bdf390e12a9bbca3f2889d3e99fab9476d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/baae3447b9e9933e09b04e79033e527c30ef3841b0f21bfa135cd809bd3ecdff054692bf90603b0ac921cb53327e43f9675ecf02dae3bd3387c1604c8981f609"} 12:31:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:31:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:31:26 INFO - Contents: 12:31:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caa062afb935e8578de2b4244e9f0a08374b36e91fbaaf34f95c86adc68f3d733f83fc9a683acaea6255d9bf64d051d01f70f456ad22eda047454baa0a9213ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96f92747737f1dc3acafa8a162cef25a081bf0d6d49d40b92a7c3e4269c4de5f452f7cdd09552203363e10ceca9e20bdf390e12a9bbca3f2889d3e99fab9476d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/baae3447b9e9933e09b04e79033e527c30ef3841b0f21bfa135cd809bd3ecdff054692bf90603b0ac921cb53327e43f9675ecf02dae3bd3387c1604c8981f609"} 12:31:26 INFO - Running post-run listener: copy_logs_to_upload_dir 12:31:26 INFO - Copying logs to upload dir... 12:31:26 INFO - mkdir: /builds/slave/test/build/upload/logs 12:31:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.428718 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-04 12:31:25.867747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 12:31:25.873417) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caa062afb935e8578de2b4244e9f0a08374b36e91fbaaf34f95c86adc68f3d733f83fc9a683acaea6255d9bf64d051d01f70f456ad22eda047454baa0a9213ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96f92747737f1dc3acafa8a162cef25a081bf0d6d49d40b92a7c3e4269c4de5f452f7cdd09552203363e10ceca9e20bdf390e12a9bbca3f2889d3e99fab9476d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/baae3447b9e9933e09b04e79033e527c30ef3841b0f21bfa135cd809bd3ecdff054692bf90603b0ac921cb53327e43f9675ecf02dae3bd3387c1604c8981f609"} build_url:https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/RY4KsDZFTXefh5Y4qkONlA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caa062afb935e8578de2b4244e9f0a08374b36e91fbaaf34f95c86adc68f3d733f83fc9a683acaea6255d9bf64d051d01f70f456ad22eda047454baa0a9213ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96f92747737f1dc3acafa8a162cef25a081bf0d6d49d40b92a7c3e4269c4de5f452f7cdd09552203363e10ceca9e20bdf390e12a9bbca3f2889d3e99fab9476d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/baae3447b9e9933e09b04e79033e527c30ef3841b0f21bfa135cd809bd3ecdff054692bf90603b0ac921cb53327e43f9675ecf02dae3bd3387c1604c8981f609"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 12:31:25.900737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 12:31:25.901042) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467656595.675359-1271418305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 12:31:25.949498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 12:31:25.949771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 12:31:25.950022) ========= ========= Total master_lag: 0.14 =========