builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1468431845.61 results: success (0) buildid: 20160713100745 builduid: 92a5aba3af8a400388f2cb5b467faaff revision: 3e1f197a8ebaad792fa1160831f15b3b70f9a305 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.611961) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.612426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.612730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.623984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.624265) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 10:44:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-13 10:44:06 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.748269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.748563) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015722 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.807851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:05.808255) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e1f197a8ebaad792fa1160831f15b3b70f9a305 --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 3e1f197a8ebaad792fa1160831f15b3b70f9a305 --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=934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 10:44:06,613 truncating revision to first 12 chars 2016-07-13 10:44:06,613 Setting DEBUG logging. 2016-07-13 10:44:06,613 attempt 1/10 2016-07-13 10:44:06,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e1f197a8eba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 10:44:06,930 unpacking tar archive at: fx-team-3e1f197a8eba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:06.509420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:06.509694) ========= script_repo_revision: 3e1f197a8ebaad792fa1160831f15b3b70f9a305 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:06.510101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:06.510375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:44:06.520103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-13 10:44:06.520383) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:44:07 INFO - MultiFileLogger online at 20160713 10:44:07 in /builds/slave/test 10:44:07 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 10:44:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:44:07 INFO - {'append_to_log': False, 10:44:07 INFO - 'base_work_dir': '/builds/slave/test', 10:44:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:44:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:44:07 INFO - 'branch': 'Fx-Team-Non-PGO', 10:44:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:44:07 INFO - 'config_files': ('talos/linux_config.py',), 10:44:07 INFO - 'default_actions': ('clobber', 10:44:07 INFO - 'read-buildbot-config', 10:44:07 INFO - 'download-and-extract', 10:44:07 INFO - 'populate-webroot', 10:44:07 INFO - 'create-virtualenv', 10:44:07 INFO - 'install', 10:44:07 INFO - 'run-tests'), 10:44:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:44:07 INFO - 'download_minidump_stackwalk': True, 10:44:07 INFO - 'download_symbols': 'ondemand', 10:44:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:44:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:44:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:44:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:44:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:44:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:44:07 INFO - 'installer_path': 'installer.exe', 10:44:07 INFO - 'log_level': 'info', 10:44:07 INFO - 'log_name': 'talos', 10:44:07 INFO - 'log_to_console': True, 10:44:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:44:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:44:07 INFO - 'opt_config_files': (), 10:44:07 INFO - 'pip_index': False, 10:44:07 INFO - 'sps_profile': False, 10:44:07 INFO - 'sps_profile_interval': 0, 10:44:07 INFO - 'suite': 'dromaeojs', 10:44:07 INFO - 'system_bits': '32', 10:44:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:44:07 INFO - 'title': 'talos-linux64-ix-057', 10:44:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:44:07 INFO - 'use_talos_json': True, 10:44:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:44:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:44:07 INFO - 'work_dir': 'build'} 10:44:07 INFO - ##### 10:44:07 INFO - ##### Running clobber step. 10:44:07 INFO - ##### 10:44:07 INFO - Running pre-action listener: _resource_record_pre_action 10:44:07 INFO - Running main action method: clobber 10:44:07 INFO - rmtree: /builds/slave/test/build 10:44:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:44:07 INFO - Running post-action listener: _resource_record_post_action 10:44:07 INFO - ##### 10:44:07 INFO - ##### Finished clobber step (success) 10:44:07 INFO - ##### 10:44:07 INFO - ##### 10:44:07 INFO - ##### Running read-buildbot-config step. 10:44:07 INFO - ##### 10:44:07 INFO - Running pre-action listener: _resource_record_pre_action 10:44:07 INFO - Running main action method: read_buildbot_config 10:44:07 INFO - Using buildbot properties: 10:44:07 INFO - { 10:44:07 INFO - "project": "", 10:44:07 INFO - "product": "firefox", 10:44:07 INFO - "script_repo_revision": "production", 10:44:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:44:07 INFO - "repository": "", 10:44:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:44:07 INFO - "buildid": "20160713100745", 10:44:07 INFO - "pgo_build": "False", 10:44:07 INFO - "basedir": "/builds/slave/test", 10:44:07 INFO - "buildnumber": 3148, 10:44:07 INFO - "slavename": "talos-linux64-ix-057", 10:44:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:44:07 INFO - "platform": "ubuntu64_hw", 10:44:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:44:07 INFO - "branch": "fx-team", 10:44:07 INFO - "repo_path": "integration/fx-team", 10:44:07 INFO - "revision": "3e1f197a8ebaad792fa1160831f15b3b70f9a305", 10:44:07 INFO - "stage_platform": "linux64", 10:44:07 INFO - "builduid": "92a5aba3af8a400388f2cb5b467faaff", 10:44:07 INFO - "slavebuilddir": "test" 10:44:07 INFO - } 10:44:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:44:07 INFO - Running post-action listener: _resource_record_post_action 10:44:07 INFO - ##### 10:44:07 INFO - ##### Finished read-buildbot-config step (success) 10:44:07 INFO - ##### 10:44:07 INFO - ##### 10:44:07 INFO - ##### Running download-and-extract step. 10:44:07 INFO - ##### 10:44:07 INFO - Running pre-action listener: _resource_record_pre_action 10:44:07 INFO - Running main action method: download_and_extract 10:44:07 INFO - mkdir: /builds/slave/test/build/tests 10:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:07 INFO - https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:10 INFO - Downloaded 1361 bytes. 10:44:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:44:10 INFO - Using the following test package requirements: 10:44:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:44:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:44:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:44:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'jsshell-linux-x86_64.zip'], 10:44:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:44:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:44:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:44:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:44:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:44:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:44:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:10 INFO - https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:44:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:13 INFO - Downloaded 22755434 bytes. 10:44:13 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'] 10:44:13 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 10:44:14 INFO - Return code: 0 10:44:14 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 10:44: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')]} 10:44:14 INFO - https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:17 INFO - Downloaded 22755434 bytes. 10:44:17 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'] 10:44:17 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 10:44:19 INFO - Return code: 0 10:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:19 INFO - https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:20 INFO - Downloaded 14403317 bytes. 10:44:20 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'] 10:44:20 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 10:44:20 INFO - Return code: 0 10:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:20 INFO - https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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 10:44:22 INFO - Downloaded 57051028 bytes. 10:44:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:22 INFO - mkdir: /builds/slave/test/properties 10:44:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:44:22 INFO - Writing to file /builds/slave/test/properties/build_url 10:44:22 INFO - Contents: 10:44:22 INFO - build_url:https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:22 INFO - Running post-action listener: _resource_record_post_action 10:44:22 INFO - Running post-action listener: set_extra_try_arguments 10:44:22 INFO - ##### 10:44:22 INFO - ##### Finished download-and-extract step (success) 10:44:22 INFO - ##### 10:44:22 INFO - ##### 10:44:22 INFO - ##### Running populate-webroot step. 10:44:22 INFO - ##### 10:44:22 INFO - Running pre-action listener: _resource_record_pre_action 10:44:22 INFO - Running main action method: populate_webroot 10:44:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:44:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:44:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:44:22 INFO - '--tppagecycles', 10:44:22 INFO - '7'], 10:44:22 INFO - 'tests': ['tsvgm']}}, 10:44:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:44:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:44:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:44:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:44:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['damp', 'tps']}, 10:44:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'tests': ['damp', 'tps']}, 10:44:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['dromaeo_dom']}, 10:44:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:44:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['basic_compositor_video']}, 10:44:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:44:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['a11yr', 10:44:22 INFO - 'ts_paint', 10:44:22 INFO - 'tpaint', 10:44:22 INFO - 'sessionrestore', 10:44:22 INFO - 'sessionrestore_no_auto_restore', 10:44:22 INFO - 'tabpaint']}, 10:44:22 INFO - 'other-e10s': {'tests': ['a11yr', 10:44:22 INFO - 'ts_paint', 10:44:22 INFO - 'tpaint', 10:44:22 INFO - 'sessionrestore', 10:44:22 INFO - 'sessionrestore_no_auto_restore', 10:44:22 INFO - 'tabpaint']}, 10:44:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:44:22 INFO - 'ts_paint', 10:44:22 INFO - 'tpaint', 10:44:22 INFO - 'sessionrestore', 10:44:22 INFO - 'sessionrestore_no_auto_restore', 10:44:22 INFO - 'tabpaint']}, 10:44:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:44:22 INFO - 'ts_paint', 10:44:22 INFO - 'tpaint', 10:44:22 INFO - 'sessionrestore', 10:44:22 INFO - 'sessionrestore_no_auto_restore', 10:44:22 INFO - 'tabpaint']}, 10:44:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['a11yr', 10:44:22 INFO - 'ts_paint', 10:44:22 INFO - 'tpaint', 10:44:22 INFO - 'sessionrestore', 10:44:22 INFO - 'sessionrestore_no_auto_restore', 10:44:22 INFO - 'tabpaint']}, 10:44:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['a11yr', 10:44:22 INFO - 'ts_paint', 10:44:22 INFO - 'tpaint', 10:44:22 INFO - 'sessionrestore', 10:44:22 INFO - 'sessionrestore_no_auto_restore', 10:44:22 INFO - 'tabpaint']}, 10:44:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['tsvgx', 10:44:22 INFO - 'tsvgr_opacity', 10:44:22 INFO - 'tart', 10:44:22 INFO - 'tscrollx', 10:44:22 INFO - 'cart']}, 10:44:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:44:22 INFO - 'tsvgr_opacity', 10:44:22 INFO - 'tart', 10:44:22 INFO - 'tscrollx', 10:44:22 INFO - 'cart']}, 10:44:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'talos_options': ['--disable-e10s'], 10:44:22 INFO - 'tests': ['tp5o']}, 10:44:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'tests': ['tp5o']}, 10:44:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'talos_options': ['--disable-e10s', 10:44:22 INFO - '--xperf_path', 10:44:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:22 INFO - 'tests': ['tp5n']}, 10:44:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:22 INFO - 'talos_options': ['--xperf_path', 10:44:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:22 INFO - 'tests': ['tp5n']}}, 10:44:22 INFO - 'talos.zip': {'path': '', 10:44:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:44:22 INFO - Running post-action listener: _resource_record_post_action 10:44:22 INFO - ##### 10:44:22 INFO - ##### Finished populate-webroot step (success) 10:44:22 INFO - ##### 10:44:22 INFO - ##### 10:44:22 INFO - ##### Running create-virtualenv step. 10:44:22 INFO - ##### 10:44:22 INFO - Running pre-action listener: _resource_record_pre_action 10:44:22 INFO - Running main action method: create_virtualenv 10:44:22 INFO - Creating virtualenv /builds/slave/test/build/venv 10:44:22 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 10:44:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:44:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:44:22 INFO - Using real prefix '/usr' 10:44:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:44:23 INFO - Installing distribute.............................................................................................................................................................................................done. 10:44:25 INFO - Installing pip.................done. 10:44:25 INFO - Return code: 0 10:44:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:25 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:25 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 10:44:25 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 10:44:25 INFO - Using env: {'DISPLAY': ':0', 10:44:25 INFO - 'HOME': '/home/cltbld', 10:44:25 INFO - 'LANG': 'en_US.UTF-8', 10:44:25 INFO - 'LANGUAGE': 'en_US:en', 10:44:25 INFO - 'LOGNAME': 'cltbld', 10:44:25 INFO - 'MAIL': '/var/mail/cltbld', 10:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:25 INFO - 'MOZ_NO_REMOTE': '1', 10:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:25 INFO - 'NO_EM_RESTART': '1', 10:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:25 INFO - 'PWD': '/builds/slave/test', 10:44:25 INFO - 'SHELL': '/bin/bash', 10:44:25 INFO - 'SHLVL': '1', 10:44:25 INFO - 'TERM': 'linux', 10:44:25 INFO - 'TMOUT': '86400', 10:44:25 INFO - 'USER': 'cltbld', 10:44:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:25 INFO - '_': '/tools/buildbot/bin/python'} 10:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:25 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 10:44:25 INFO - Cleaning up... 10:44:25 INFO - Return code: 0 10:44:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:25 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:25 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 10:44:25 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 10:44:25 INFO - Using env: {'DISPLAY': ':0', 10:44:25 INFO - 'HOME': '/home/cltbld', 10:44:25 INFO - 'LANG': 'en_US.UTF-8', 10:44:25 INFO - 'LANGUAGE': 'en_US:en', 10:44:25 INFO - 'LOGNAME': 'cltbld', 10:44:25 INFO - 'MAIL': '/var/mail/cltbld', 10:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:25 INFO - 'MOZ_NO_REMOTE': '1', 10:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:25 INFO - 'NO_EM_RESTART': '1', 10:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:25 INFO - 'PWD': '/builds/slave/test', 10:44:25 INFO - 'SHELL': '/bin/bash', 10:44:25 INFO - 'SHLVL': '1', 10:44:25 INFO - 'TERM': 'linux', 10:44:25 INFO - 'TMOUT': '86400', 10:44:25 INFO - 'USER': 'cltbld', 10:44:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:25 INFO - '_': '/tools/buildbot/bin/python'} 10:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:25 INFO - Downloading/unpacking psutil>=3.1.1 10:44:25 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 10:44:25 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 10:44:25 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 10:44:25 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 10:44:25 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 10:44:25 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 10:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:44:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:27 INFO - Installing collected packages: psutil 10:44:27 INFO - Running setup.py install for psutil 10:44:27 INFO - building 'psutil._psutil_linux' extension 10:44:27 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 10:44:28 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 10:44:28 INFO - building 'psutil._psutil_posix' extension 10:44:28 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 10:44:28 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 10:44:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:28 INFO - Successfully installed psutil 10:44:28 INFO - Cleaning up... 10:44:28 INFO - Return code: 0 10:44:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:44:28 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')]} 10:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:28 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')]} 10:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:28 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:28 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 10:44:28 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 10:44:28 INFO - Using env: {'DISPLAY': ':0', 10:44:28 INFO - 'HOME': '/home/cltbld', 10:44:28 INFO - 'LANG': 'en_US.UTF-8', 10:44:28 INFO - 'LANGUAGE': 'en_US:en', 10:44:28 INFO - 'LOGNAME': 'cltbld', 10:44:28 INFO - 'MAIL': '/var/mail/cltbld', 10:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:28 INFO - 'MOZ_NO_REMOTE': '1', 10:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:28 INFO - 'NO_EM_RESTART': '1', 10:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:28 INFO - 'PWD': '/builds/slave/test', 10:44:28 INFO - 'SHELL': '/bin/bash', 10:44:28 INFO - 'SHLVL': '1', 10:44:28 INFO - 'TERM': 'linux', 10:44:28 INFO - 'TMOUT': '86400', 10:44:28 INFO - 'USER': 'cltbld', 10:44:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:28 INFO - '_': '/tools/buildbot/bin/python'} 10:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:44:28 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 10:44:28 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 10:44:28 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 10:44:28 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 10:44:28 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 10:44:28 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 10:44:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:44:30 INFO - Installing collected packages: mozsystemmonitor 10:44:30 INFO - Running setup.py install for mozsystemmonitor 10:44:30 INFO - Successfully installed mozsystemmonitor 10:44:30 INFO - Cleaning up... 10:44:30 INFO - Return code: 0 10:44:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:30 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:30 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 10:44:30 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 10:44:30 INFO - Using env: {'DISPLAY': ':0', 10:44:30 INFO - 'HOME': '/home/cltbld', 10:44:30 INFO - 'LANG': 'en_US.UTF-8', 10:44:30 INFO - 'LANGUAGE': 'en_US:en', 10:44:30 INFO - 'LOGNAME': 'cltbld', 10:44:30 INFO - 'MAIL': '/var/mail/cltbld', 10:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:30 INFO - 'MOZ_NO_REMOTE': '1', 10:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:30 INFO - 'NO_EM_RESTART': '1', 10:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:30 INFO - 'PWD': '/builds/slave/test', 10:44:30 INFO - 'SHELL': '/bin/bash', 10:44:30 INFO - 'SHLVL': '1', 10:44:30 INFO - 'TERM': 'linux', 10:44:30 INFO - 'TMOUT': '86400', 10:44:30 INFO - 'USER': 'cltbld', 10:44:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:30 INFO - '_': '/tools/buildbot/bin/python'} 10:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:44:31 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 10:44:31 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 10:44:31 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 10:44:31 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 10:44:31 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 10:44:31 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 10:44:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:44:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:44:32 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 10:44:32 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 10:44:32 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 10:44:32 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 10:44:32 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 10:44:32 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 10:44:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:44:33 INFO - warning: no files found matching '*.txt' 10:44:33 INFO - no previously-included directories found matching 'build' 10:44:33 INFO - no previously-included directories found matching 'dist' 10:44:33 INFO - no previously-included directories found matching '.git*' 10:44:33 INFO - Installing collected packages: jsonschema, functools32 10:44:33 INFO - Running setup.py install for functools32 10:44:33 INFO - warning: no files found matching '*.txt' 10:44:33 INFO - no previously-included directories found matching 'build' 10:44:33 INFO - no previously-included directories found matching 'dist' 10:44:33 INFO - no previously-included directories found matching '.git*' 10:44:33 INFO - Successfully installed jsonschema functools32 10:44:33 INFO - Cleaning up... 10:44:33 INFO - Return code: 0 10:44:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:44:33 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')]} 10:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:33 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')]} 10:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:33 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:33 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 10:44:33 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 10:44:33 INFO - Using env: {'DISPLAY': ':0', 10:44:33 INFO - 'HOME': '/home/cltbld', 10:44:33 INFO - 'LANG': 'en_US.UTF-8', 10:44:33 INFO - 'LANGUAGE': 'en_US:en', 10:44:33 INFO - 'LOGNAME': 'cltbld', 10:44:33 INFO - 'MAIL': '/var/mail/cltbld', 10:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:33 INFO - 'MOZ_NO_REMOTE': '1', 10:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:33 INFO - 'NO_EM_RESTART': '1', 10:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:33 INFO - 'PWD': '/builds/slave/test', 10:44:33 INFO - 'SHELL': '/bin/bash', 10:44:33 INFO - 'SHLVL': '1', 10:44:33 INFO - 'TERM': 'linux', 10:44:33 INFO - 'TMOUT': '86400', 10:44:33 INFO - 'USER': 'cltbld', 10:44:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:33 INFO - '_': '/tools/buildbot/bin/python'} 10:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:44:33 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 10:44:33 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 10:44:33 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 10:44:33 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 10:44:33 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 10:44:33 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 10:44:35 INFO - Downloading blobuploader-1.2.4.tar.gz 10:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:44:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:44:35 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 10:44:35 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 10:44:35 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 10:44:35 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 10:44:35 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 10:44:35 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 10:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:44:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:36 INFO - Downloading docopt-0.6.1.tar.gz 10:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:44:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:44:36 INFO - Running setup.py install for blobuploader 10:44:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:44:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:44:36 INFO - Running setup.py install for requests 10:44:36 INFO - Running setup.py install for docopt 10:44:36 INFO - Successfully installed blobuploader requests docopt 10:44:36 INFO - Cleaning up... 10:44:36 INFO - Return code: 0 10:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44: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')]} 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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')]} 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:36 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:36 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 10:44:36 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 10:44:36 INFO - Using env: {'DISPLAY': ':0', 10:44:36 INFO - 'HOME': '/home/cltbld', 10:44:36 INFO - 'LANG': 'en_US.UTF-8', 10:44:36 INFO - 'LANGUAGE': 'en_US:en', 10:44:36 INFO - 'LOGNAME': 'cltbld', 10:44:36 INFO - 'MAIL': '/var/mail/cltbld', 10:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:36 INFO - 'MOZ_NO_REMOTE': '1', 10:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:36 INFO - 'NO_EM_RESTART': '1', 10:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:36 INFO - 'PWD': '/builds/slave/test', 10:44:36 INFO - 'SHELL': '/bin/bash', 10:44:36 INFO - 'SHLVL': '1', 10:44:36 INFO - 'TERM': 'linux', 10:44:36 INFO - 'TMOUT': '86400', 10:44:36 INFO - 'USER': 'cltbld', 10:44:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:36 INFO - '_': '/tools/buildbot/bin/python'} 10:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:37 INFO - Running setup.py (path:/tmp/pip-RH_XH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:37 INFO - Running setup.py (path:/tmp/pip-cnsQqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:37 INFO - Running setup.py (path:/tmp/pip-LCphJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:37 INFO - Running setup.py (path:/tmp/pip-annD0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:37 INFO - Running setup.py (path:/tmp/pip-BZHwqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:37 INFO - Running setup.py (path:/tmp/pip-YSTLns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:37 INFO - Running setup.py (path:/tmp/pip-tgsKQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:37 INFO - Running setup.py (path:/tmp/pip-uUOlFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:37 INFO - Running setup.py (path:/tmp/pip-69MpdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:37 INFO - Running setup.py (path:/tmp/pip-tAQUWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:37 INFO - Running setup.py (path:/tmp/pip-3vMWzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:37 INFO - Running setup.py (path:/tmp/pip-m3aWiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:38 INFO - Running setup.py (path:/tmp/pip-8DBMqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:38 INFO - Running setup.py (path:/tmp/pip-QMTer3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:38 INFO - Running setup.py (path:/tmp/pip-7vxtLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:38 INFO - Running setup.py (path:/tmp/pip-xXbtF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:38 INFO - Running setup.py (path:/tmp/pip-SrZDar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:44:38 INFO - Running setup.py install for manifestparser 10:44:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:44:38 INFO - Running setup.py install for mozcrash 10:44:38 INFO - Running setup.py install for mozdebug 10:44:38 INFO - Running setup.py install for mozdevice 10:44:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:44:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:44:38 INFO - Running setup.py install for mozfile 10:44:38 INFO - Running setup.py install for mozhttpd 10:44:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:44:38 INFO - Running setup.py install for mozinfo 10:44:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Running setup.py install for mozInstall 10:44:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Running setup.py install for mozleak 10:44:39 INFO - Running setup.py install for mozlog 10:44:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Running setup.py install for moznetwork 10:44:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Running setup.py install for mozprocess 10:44:39 INFO - Running setup.py install for mozprofile 10:44:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Running setup.py install for mozrunner 10:44:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:44:39 INFO - Running setup.py install for mozscreenshot 10:44:39 INFO - Running setup.py install for moztest 10:44:40 INFO - Running setup.py install for mozversion 10:44:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:44:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:44:40 INFO - Cleaning up... 10:44:40 INFO - Return code: 0 10:44:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:40 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')]} 10:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:40 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')]} 10:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:40 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:40 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 10:44:40 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 10:44:40 INFO - Using env: {'DISPLAY': ':0', 10:44:40 INFO - 'HOME': '/home/cltbld', 10:44:40 INFO - 'LANG': 'en_US.UTF-8', 10:44:40 INFO - 'LANGUAGE': 'en_US:en', 10:44:40 INFO - 'LOGNAME': 'cltbld', 10:44:40 INFO - 'MAIL': '/var/mail/cltbld', 10:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:40 INFO - 'MOZ_NO_REMOTE': '1', 10:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:40 INFO - 'NO_EM_RESTART': '1', 10:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:40 INFO - 'PWD': '/builds/slave/test', 10:44:40 INFO - 'SHELL': '/bin/bash', 10:44:40 INFO - 'SHLVL': '1', 10:44:40 INFO - 'TERM': 'linux', 10:44:40 INFO - 'TMOUT': '86400', 10:44:40 INFO - 'USER': 'cltbld', 10:44:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:40 INFO - '_': '/tools/buildbot/bin/python'} 10:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:40 INFO - Running setup.py (path:/tmp/pip-EtO7q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:40 INFO - Running setup.py (path:/tmp/pip-yAmTvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:40 INFO - Running setup.py (path:/tmp/pip-pKAT_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:40 INFO - Running setup.py (path:/tmp/pip-iW0ZM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:40 INFO - Running setup.py (path:/tmp/pip-hJhtJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:40 INFO - Running setup.py (path:/tmp/pip-XPhIsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:40 INFO - Running setup.py (path:/tmp/pip-Kn81Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:40 INFO - Running setup.py (path:/tmp/pip-OfqcGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:40 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)) 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:40 INFO - Running setup.py (path:/tmp/pip-Au_sQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:41 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)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:41 INFO - Running setup.py (path:/tmp/pip-iKqa76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:41 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)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:41 INFO - Running setup.py (path:/tmp/pip-wupmth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:41 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)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:41 INFO - Running setup.py (path:/tmp/pip-As6JZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:41 INFO - Running setup.py (path:/tmp/pip-7wBQG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:41 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)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:41 INFO - Running setup.py (path:/tmp/pip-JhUVZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:41 INFO - Running setup.py (path:/tmp/pip-KaSJjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:41 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)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:41 INFO - Running setup.py (path:/tmp/pip-eBC9cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:41 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)) 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:41 INFO - Running setup.py (path:/tmp/pip-2IA3YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:41 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)) 10:44:41 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)) 10:44:41 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)) 10:44:41 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)) 10:44:41 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)) 10:44:41 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)) 10:44:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:44:41 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 10:44:41 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 10:44:41 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 10:44:41 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 10:44:41 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 10:44:41 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 10:44:43 INFO - Downloading blessings-1.6.tar.gz 10:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:44:43 INFO - Installing collected packages: blessings 10:44:43 INFO - Running setup.py install for blessings 10:44:43 INFO - Successfully installed blessings 10:44:43 INFO - Cleaning up... 10:44:43 INFO - Return code: 0 10:44:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:44:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:44 INFO - Reading from file tmpfile_stdout 10:44:44 INFO - Current package versions: 10:44:44 INFO - argparse == 1.2.1 10:44:44 INFO - blessings == 1.6 10:44:44 INFO - blobuploader == 1.2.4 10:44:44 INFO - docopt == 0.6.1 10:44:44 INFO - functools32 == 3.2.3-2 10:44:44 INFO - jsonschema == 2.5.1 10:44:44 INFO - manifestparser == 1.1 10:44:44 INFO - mozInstall == 1.12 10:44:44 INFO - mozcrash == 0.17 10:44:44 INFO - mozdebug == 0.1 10:44:44 INFO - mozdevice == 0.48 10:44:44 INFO - mozfile == 1.2 10:44:44 INFO - mozhttpd == 0.7 10:44:44 INFO - mozinfo == 0.9 10:44:44 INFO - mozleak == 0.1 10:44:44 INFO - mozlog == 3.2 10:44:44 INFO - moznetwork == 0.27 10:44:44 INFO - mozprocess == 0.23 10:44:44 INFO - mozprofile == 0.28 10:44:44 INFO - mozrunner == 6.12 10:44:44 INFO - mozscreenshot == 0.1 10:44:44 INFO - mozsystemmonitor == 0.3 10:44:44 INFO - moztest == 0.7 10:44:44 INFO - mozversion == 1.4 10:44:44 INFO - psutil == 3.1.1 10:44:44 INFO - requests == 1.2.3 10:44:44 INFO - wsgiref == 0.1.2 10:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:44 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:44 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 10:44:44 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 10:44:44 INFO - Using env: {'DISPLAY': ':0', 10:44:44 INFO - 'HOME': '/home/cltbld', 10:44:44 INFO - 'LANG': 'en_US.UTF-8', 10:44:44 INFO - 'LANGUAGE': 'en_US:en', 10:44:44 INFO - 'LOGNAME': 'cltbld', 10:44:44 INFO - 'MAIL': '/var/mail/cltbld', 10:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:44 INFO - 'MOZ_NO_REMOTE': '1', 10:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:44 INFO - 'NO_EM_RESTART': '1', 10:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:44 INFO - 'PWD': '/builds/slave/test', 10:44:44 INFO - 'SHELL': '/bin/bash', 10:44:44 INFO - 'SHLVL': '1', 10:44:44 INFO - 'TERM': 'linux', 10:44:44 INFO - 'TMOUT': '86400', 10:44:44 INFO - 'USER': 'cltbld', 10:44:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:44 INFO - '_': '/tools/buildbot/bin/python'} 10:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 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)) 10:44:44 INFO - Cleaning up... 10:44:44 INFO - Return code: 0 10:44:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', '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 10:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:44:44 INFO - Using env: {'DISPLAY': ':0', 10:44:44 INFO - 'HOME': '/home/cltbld', 10:44:44 INFO - 'LANG': 'en_US.UTF-8', 10:44:44 INFO - 'LANGUAGE': 'en_US:en', 10:44:44 INFO - 'LOGNAME': 'cltbld', 10:44:44 INFO - 'MAIL': '/var/mail/cltbld', 10:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:44 INFO - 'MOZ_NO_REMOTE': '1', 10:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:44 INFO - 'NO_EM_RESTART': '1', 10:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:44 INFO - 'PWD': '/builds/slave/test', 10:44:44 INFO - 'SHELL': '/bin/bash', 10:44:44 INFO - 'SHLVL': '1', 10:44:44 INFO - 'TERM': 'linux', 10:44:44 INFO - 'TMOUT': '86400', 10:44:44 INFO - 'USER': 'cltbld', 10:44:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:44 INFO - '_': '/tools/buildbot/bin/python'} 10:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:44:44 INFO - Cleaning up... 10:44:44 INFO - Return code: 0 10:44:44 INFO - Running post-action listener: _resource_record_post_action 10:44:44 INFO - Running post-action listener: _start_resource_monitoring 10:44:44 INFO - Starting resource monitoring. 10:44:44 INFO - ##### 10:44:44 INFO - ##### Finished create-virtualenv step (success) 10:44:44 INFO - ##### 10:44:44 INFO - ##### 10:44:44 INFO - ##### Running install step. 10:44:44 INFO - ##### 10:44:44 INFO - Running pre-action listener: _resource_record_pre_action 10:44:44 INFO - Running main action method: install 10:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:44 INFO - Reading from file tmpfile_stdout 10:44:44 INFO - Detecting whether we're running mozinstall >=1.0... 10:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:44:44 INFO - Reading from file tmpfile_stdout 10:44:44 INFO - Output received: 10:44:44 INFO - Usage: mozinstall [options] installer 10:44:44 INFO - Options: 10:44:44 INFO - -h, --help show this help message and exit 10:44:44 INFO - -d DEST, --destination=DEST 10:44:44 INFO - Directory to install application into. [default: 10:44:44 INFO - "/builds/slave/test"] 10:44:44 INFO - --app=APP Application being installed. [default: firefox] 10:44:44 INFO - mkdir: /builds/slave/test/build/application 10:44:44 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'] 10:44:44 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 10:45:01 INFO - Reading from file tmpfile_stdout 10:45:01 INFO - Output received: 10:45:01 INFO - /builds/slave/test/build/application/firefox/firefox 10:45:01 INFO - Running post-action listener: _resource_record_post_action 10:45:01 INFO - ##### 10:45:01 INFO - ##### Finished install step (success) 10:45:01 INFO - ##### 10:45:01 INFO - ##### 10:45:01 INFO - ##### Running run-tests step. 10:45:01 INFO - ##### 10:45:01 INFO - Running pre-action listener: _resource_record_pre_action 10:45:01 INFO - Running main action method: run_tests 10:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:45:01 INFO - Python 2.7.3 10:45:01 INFO - Return code: 0 10:45:01 INFO - grabbing minidump binary from tooltool 10:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:01 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 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:45:01 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 10:45:01 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 10:45:01 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 10:45:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:45:01 INFO - Return code: 0 10:45:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:45:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:45:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:45:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:45:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:45:01 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/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 10:45:01 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/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 10:45:01 INFO - Using env: {'DISPLAY': ':0', 10:45:01 INFO - 'HOME': '/home/cltbld', 10:45:01 INFO - 'LANG': 'en_US.UTF-8', 10:45:01 INFO - 'LANGUAGE': 'en_US:en', 10:45:01 INFO - 'LOGNAME': 'cltbld', 10:45:01 INFO - 'MAIL': '/var/mail/cltbld', 10:45:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:45:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:01 INFO - 'MOZ_NO_REMOTE': '1', 10:45:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:01 INFO - 'NO_EM_RESTART': '1', 10:45:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:01 INFO - 'PWD': '/builds/slave/test', 10:45:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:45:01 INFO - 'SHELL': '/bin/bash', 10:45:01 INFO - 'SHLVL': '1', 10:45:01 INFO - 'TERM': 'linux', 10:45:01 INFO - 'TMOUT': '86400', 10:45:01 INFO - 'USER': 'cltbld', 10:45:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725', 10:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:01 INFO - '_': '/tools/buildbot/bin/python'} 10:45:01 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/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 10:45:01 INFO - mozversion application_buildid: 20160713100745 10:45:01 INFO - mozversion application_changeset: 3e1f197a8ebaad792fa1160831f15b3b70f9a305 10:45:01 INFO - mozversion application_display_name: Nightly 10:45:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:45:01 INFO - mozversion application_name: Firefox 10:45:01 INFO - mozversion application_remotingname: firefox 10:45:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:45:01 INFO - mozversion application_vendor: Mozilla 10:45:01 INFO - mozversion application_version: 50.0a1 10:45:01 INFO - mozversion platform_buildid: 20160713100745 10:45:01 INFO - mozversion platform_changeset: 3e1f197a8ebaad792fa1160831f15b3b70f9a305 10:45:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:45:01 INFO - mozversion platform_version: 50.0a1 10:45:01 INFO - using testdate: 1468431901 10:45:01 INFO - actual date: 1468431901 10:45:01 INFO - starting webserver on 'localhost:33898' 10:45:01 INFO - SUITE-START | Running 2 tests 10:45:01 INFO - TEST-START | dromaeo_css 10:45:01 INFO - operating with platform_type : linux_ 10:45:01 INFO - Initialising browser for dromaeo_css test... 10:45:01 INFO - TEST-INFO | started process 15704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNWs6BD/profile http://localhost:33898/getInfo.html) 10:45:05 INFO - PROCESS | 15704 | __metrics Screen width/height:1600/1200 10:45:05 INFO - PROCESS | 15704 | colorDepth:24 10:45:05 INFO - PROCESS | 15704 | Browser inner width/height: 1024/697 10:45:05 INFO - PROCESS | 15704 | __metrics 10:45:06 INFO - PROCESS | 15704 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:45:06 INFO - PROCESS | 15704 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:45:07 INFO - TEST-INFO | 15704: exit 0 10:45:07 INFO - Browser initialized. 10:45:07 INFO - Running cycle 1/1 for dromaeo_css test... 10:45:07 INFO - TEST-INFO | started process 15784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNWs6BD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:19 INFO - PROCESS | 15784 | RSS: Main: 159133696 10:45:19 INFO - PROCESS | 15784 | 10:46:11 INFO - PROCESS | 15784 | 1468431971084 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] 10:48:23 INFO - PROCESS | 15784 | Cycle 1(1): loaded http://localhost:33898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33898/tests/dromaeo/cssquery-ext.html) 10:48:24 INFO - PROCESS | 15784 | RSS: Main: 250388480 10:48:24 INFO - PROCESS | 15784 | 10:51:27 INFO - PROCESS | 15784 | Cycle 1(1): loaded http://localhost:33898/tests/dromaeo/cssquery-ext.html (next: http://localhost:33898/tests/dromaeo/cssquery-jquery.html) 10:51:27 INFO - PROCESS | 15784 | RSS: Main: 244006912 10:51:27 INFO - PROCESS | 15784 | 10:54:29 INFO - PROCESS | 15784 | Cycle 1(1): loaded http://localhost:33898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33898/tests/dromaeo/cssquery-mootools.html) 10:54:30 INFO - PROCESS | 15784 | RSS: Main: 244056064 10:54:30 INFO - PROCESS | 15784 | 10:57:32 INFO - PROCESS | 15784 | Cycle 1(1): loaded http://localhost:33898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33898/tests/dromaeo/cssquery-prototype.html) 10:57:33 INFO - PROCESS | 15784 | RSS: Main: 238268416 10:57:33 INFO - PROCESS | 15784 | 11:00:36 INFO - PROCESS | 15784 | Cycle 1(1): loaded http://localhost:33898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33898/tests/dromaeo/cssquery-yui.html) 11:00:36 INFO - PROCESS | 15784 | RSS: Main: 218955776 11:00:36 INFO - PROCESS | 15784 | 11:03:39 INFO - PROCESS | 15784 | Cycle 1(1): loaded http://localhost:33898/tests/dromaeo/cssquery-yui.html (next: http://localhost:33898/tests/dromaeo/cssquery-dojo.html) 11:03:40 INFO - PROCESS | 15784 | RSS: Main: 293507072 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | __start_tp_report 11:03:40 INFO - PROCESS | 15784 | _x_x_mozilla_page_load 11:03:40 INFO - PROCESS | 15784 | _x_x_mozilla_page_load_details 11:03:40 INFO - PROCESS | 15784 | |i|pagename|runs| 11:03:40 INFO - PROCESS | 15784 | |0;dojo.html;2560.8079394045444;2580.9870950645245;2583.728708485608;2619.09641173795;2623.4884197581455;4443.933340999887;4498.572635599621;4582.610478109361;4589.954100458998;4603.171429142753;4525.570070843273;4561.042181141956;4586.403767510227;4610.239310513761;4632.583067523922;4192.874213773592;4198.265303571863;4206.789660516977;4266.466691663542;4289.442372491588;4224.324108142698;4261.722988005769;4288.442502474674;4303.26844436445;4304.010077682135;4084.7957602120073;4115.650169735576;4120.526139493966;4246.278132717445;4282.464691913527;4157.750534967911;4174.895627609304;4178.101708132735;4182.121754431573;4185.183889141618;4136.524299705542;4164.437800896871;4191.203671302443;4213.494380674308;4236.025714085747;4590.540945905383;4642.79107440166;4644.117617652635;4653.95346046542;4690.1557719610455;4684.508126646721;4974.204127339608;4974.950250497485;4993.201087825967;4994.076095922266;4826.758662066918;4836.46798852126;4869.440014398318;4877.341558889575;4895.265710143472;4548.090381923563;4566.360709500673;4598.195315819752;4602.976985115053;4609.700369476041;4831.661783675179;4957.752112394366;5025.020121076428;5026.824061157842;5032.0690672225755;4838.564529192389;4861.975690121527;4887.560119589183;4902.828401005948;4907.018596280758;4865.756712164378;4895.094407534618;4936.851894443173;4937.136001199776;4937.210046392632;4680.765961701902;4695.5069717679835;4815.133276010351;4857.028594281087;4869.220924652039;4820.25286080658;4827.324174615556;4836.056968891033;4858.5384388483035;4890.926636100461;4103.97948010258;4113.794310284534;4124.546299907008;4125.401816736617;4152.667786577066;3523.5947865995226;3525.9823700881843;3555.6977656898935;3609.296187243515;3618.0773902654655;4214;4226.535081141072;4241.300185469425;4288.035192081819;4290.935635965463;4941.2341087130835;4947.6536642434685;4951.678140920829;4961.131801934647;5005.224190250517;4101.651359634405;4161.417401563723;4219.810108545123;4234.894127646833;4266.0827921996915;4356;4384.7369157850635;4386;4402.779861006937;4412.779361031936;4638.1187574360765;4651.627869770478;4659.161350956792;4686.625069994392;4696.600788932979;4718.009218064245;4910.091633047898;4910.8772280693265;4921.188003979447;4924.704517728947;4665.813367465264;4665.86002419928;4670.276107203389;4690.1792186366565;4733.8343157990685;4880.658353915192;4894.486078961801;4899.31409602663;4900.558949694545;4928.137575924271;4692.859214223578;4883.511648835088;4912.336834527436;4961.70229786214;4992.450830408725;4776.59398951093;4787.42550893895;4796.304535842353;4832.613390928787;4846.781894814671;4818.831340903192;4824.0834241494;4833.685810422452;4845.8061677533915;4898.632602554751;4530.161920044802;4683.742394168354;4742.407199100113;4742.834000809955;4749.976250118727;4809.374781278551;4813.542713442217;4828.5412885775795;4834.468208497133;4873.074115917964;4710.858674239778;4711.811527538997;4721.197396442682;4724.71651700899;4774.546418090275 11:03:40 INFO - PROCESS | 15784 | |1;ext.html;567.9914801277979;568.2215364950019;576.3688760806915;580.1993249315943;581.2705055155781;26894.73105268947;37966.62033379665;39170.8041459793;39220;42767.35848962268;38979;39396.60603393965;39418.211635767264;39427.605723942754;39447;7571.356434703057;7922.3266022388025;8075.273225409712;8081.43429959903;8090.110087890327;7667.961660191719;7761.0298712660915;7765.301122898938;10040.196784257241;10352.79294414115;10425.947870260676;10465.73835654111;10469.895301046969;10491.108255798228;10497.580096796119;10271.075603195712;10313.587456501731;10321.380717156919;10341.638042668508;10345.896541034568;7479.102507699056;7732.3040926316335;7748.380129589676;9785.412875227508;10196.54115564794;37448;37754.244915101546;37820.62179378226;37831.810840945895;37849.43225851614;2867.845370092902;2869.8421586812715;2943.9116826495024;3028.242939265184;3430;27741.196822206493;27815.721842781717;27988.720112798816;28310.575341369895;28747.425051499064;2977.456826376605;2981.925451863699;2983.075246673538;3008.7893847430687;3054.862531186102;254375;255510.94689792054;256628;256838;256930;50001.74999124981;50204;50270.24594631083;50281;50291.49708502941;53264.73367633137;53326;53400.198997015075;53406;53553.464465355624;14299.928500357431;14672.119672819452;14685.19231442281;14686.706265874624;14687.339069741887;10028.047335503115;10028.147607453448;10033.598656053677;10072.899271007343;10274.22943279257;14477.203753793643;14829.332680029425;14987;15012.549623511311;15231.847681523042;5585.134304182777;5608.49523542875;5641.633293835887;5659.773609055674;5737.971310143506;834.8747687846871;911.6854685133618;941.8257622339889;962.6149540183983;975.5219942228257;26275.605865912028;26842.32894177622;27425.86287068552;27627.86186069057;27775.722242777716;928.5125309212717;932.38462614674;943.9197668198143;991.945443000642;1022.9846552301722;13805.378757955916;14407.631275028856;14500.927495362455;14760.926195368955;14778.965472416827;365646;369243;369282;370689;370925;46797.29804052942;46995;47025;47046.52953470421;47090.5290947093;1075.1452595186845;1099.5381939585393;1160.6634076117832;1180.4864883775585;1193.6956076200513;25865.482690346464;28332.15003549897;28648.283792905346;28719.42561148807;29192.27019324449;40155.39766903557;40621.593784061784;40963.7951810239;40975;41019.79490102531;308710;308745;310517;310613;312884;30188.24529386783;34750;34953;35589;35973.28053438864;39678.404823927085;40072.79963600163;40310.596894030685;40843;41145.58854411537;35206.82396588001;35286.823565882005;35319.11702207466;35837.64162358343;36038;35334.646653533135;35897.28205435929;35960.28079438449;35998.4600231002;36221;33706.49440258349;34248.31503369869;34445.655543445246;34690.132746681535;35044;29763.107106786832;30979.380412391176;31063.223419414695;31255.53116703297;31295.21761955878;23753.52492950166;24003.879980599984;24363.65999869953;24407.51184976326;24433 11:03:40 INFO - PROCESS | 15784 | |2;jquery.html;346.78970393327296;364.4387643029734;376.905773556611;377.2793963529658;399.1737104194317;13177.802332965;13616.251106189167;16383.59041023975;17595.56011099723;17619.823801761977;16242.350305987746;17653.117344132774;17669.20488578014;17676.734848977274;17695.646087078283;4997.975010124954;5131.615128865331;5175.58595312376;5189.870253243661;5195.168772996321;3759.191773768639;5858.1505681676135;6145.170401995741;6153.35389784073;6257.186565746447;6034.24571928509;6067.211262535886;6160.19917410736;6199.225096862892;6205.193324867761;6027.698615069273;6083.756649734005;6100.938990610081;6142.969285153546;6147.661878596676;4743.549362810562;5064.670796398223;5073.1122053640465;5251.212318152269;5257.526822585947;12473.438695258736;12494.937525312314;12500.624981250578;12643.873561264361;19271.30201771753;1711.5036639374566;1713.6915355236054;1885.8868467891832;1969.8522610804248;1986.2650819196845;9142.222911052568;9492.762680932963;9669.661561845372;9841.704748857546;12854.293013884233;1623.123513302827;1697.949061528156;1699.0315520153517;1701.387500499819;1734.6877562038828;62439.68780156116;66081.339186608;68771.31228687699;70868.93696594606;70922.64538677274;8553.786155346043;8795.076516965626;9182.67860624875;9286.767830804283;10314.896851031393;12044.337561434206;12050.035997120385;12060.457279422448;12122.212056216318;12141.271523708605;6981.511294209458;7137.10786151731;7163.3552980232025;7164.498485106097;7210.206877243499;6958.199807022257;6993.6503174841055;7106.502544821917;7140;7142.821434463255;3812.8856134316015;3825.2731980923536;3826.6364695354455;3860.4595356650093;3924.8626298080003;1566.8824838137186;1694.0259350873298;1703.6848183085922;1726.1369315342329;1756.297481007607;714.4784307455586;830.2195935820309;835.8370117827087;867.2888231650113;879.4107947675074;10814.837777433344;11060.834087488694;11122.777544449227;11303.561526125613;11349.716257093638;392.8683890896582;393.04686136119795;401.3798681037804;405.36965019395126;415.77548124012696;9552.37909535878;10364.481775911174;10495.212859035602;10812.56749730002;10954.123670106372;366269;376025;381726;381801;382225;41307.38038929419;66476.33523664798;81238.59380703059;81578.59210703909;81597;426.88260728299343;431.833744008559;433.18561105122797;433.7982837980354;434.97172683775455;10454.843177352193;10646.627368042082;10708.089812366035;10792.190585705946;10832;37599.248015040095;38429.80785096057;38618;38702.67783932973;38836.805815970736;51849;52670.473295268086;54056;54085.72957135189;54165.45834541762;7326.3040011198855;7357.632118393952;7481.925180748123;7641.579713115832;7722;10607.734806629896;11024.559017639205;11152.888471115184;11153.386563739072;11346.773064538827;9476.810463790824;9750.122488976027;9860.265495558497;9894.950525247616;10049.598016079275;9722.416655000723;9785.31502794826;9799.951000245239;9871.654492092743;9934.105930466292;9782.608695652094;9946.602135914482;10025.498725063864;10071.546780395047;10150.289479736643;7521.736739214101;7591.620418978919;7622.8094297643;7627.275408836152;7756.418268629763;7662.770116896502;9624.615015399586;9837.360571562825;10063.849042264519;10071.194304455772 11:03:40 INFO - PROCESS | 15784 | |3;mootools.html;1385.8822000129987;1437.0874494695868;1535.9308831102599;1714.4513755598198;1734.8698847586434;6607.5044371672075;6844.8973265401055;7653.770386888388;8095.473794203373;8104.797380065501;7649.082110146776;7960.840783184332;7963.522188668684;8043.798905027377;8113.716019939303;2118.8728676279397;2143.721316228888;2144.4960434297927;2145.7639659637425;2147.2699282244034;1840.6318736252736;1892.0445175186512;1894.4506093232947;1915.549845786239;2200.8129309008755;2175.662772270293;2251.4371407148215;2252.538229662923;2261.231181398324;2266.954660906781;2151.9031643576;2157.018556556763;2168.2302782512297;2267.818574514035;2270.375646697155;2208.03950281628;2212.8672279663274;2215.2135991722866;2215.324326080545;2235.4523141830355;8100;8162.755117346489;8164.67341306347;8168.101508834024;8168.632411541435;4450.443694538183;4606.792694328763;4610.05493873755;4613.192691279013;4613.8154473821005;2715.117586784283;2733.7129601391766;2785.8607069646437;2793.8742756576003;2798.048663454415;807.2169995104739;813.5118928642826;822.3421262989644;845.8392905347964;853.4452605806214;10980.945095274472;11037.613683521118;11040.834387484194;11049.342598610272;11051.17116216279;4032.5362583303295;4225.915481690349;4316.762578058174;4316.762578058237;4321.503027151855;9440.480773557383;9466.526673666427;9491.145796878314;9491.47796871165;9501.192398646193;4606.539346065434;4617.445906491243;4618.468876079294;4619.8845028873875;4621.884452888705;4069.694772892045;4145.91708165841;4152.148809494047;4161.0845613964875;4165.541790403053;3298.373309071269;3468.965310346864;3526.9647303526635;3545.840437180333;3712.9628703712615;1189.8517930197402;1219.0491416694992;1228.3858070964518;1228.9262644241373;1238.7859897300696;802.3982013489882;851.923326900582;854.3592305770673;861.4917198852708;863.8661007543841;5395.21769343443;5462.918056229159;5556.138798486241;5588.552915766729;5596.58025648078;892.312919052326;896.2561074308309;901.8501410701277;902.3142411767104;929.6374413978554;3760.2103558252525;3763.8870833875026;3772.86794962175;3785.9242815144094;3833.6549710526187;9018.368714189945;9167.541622918827;9230.261579073793;9301.069893010645;9313.90686093144;9226.769330766785;9244.583993720298;9249.676261330822;9255.213306868991;9259.76850578741;7067.787966361017;7072.68172932209;7146.3568278855155;7149.213586505481;7152.392046675986;5224.425313215619;5241.528262456397;5296.629235953446;5356.758945847524;5362.946370536245;8375.32997360222;8721.389502734748;8814.779630509289;8825.249853762502;8832.779180520538;8631.352648551509;8825.514596697243;8834.425762325429;8894.822103557763;9028.638854446011;6601.735930562916;6609.405153536205;6659.101021362054;6682.3317668232785;6687.6321802301345;6538.640374779433;7376.557406555624;7658.540487570764;7676.846463070819;7820.296173344426;6663.633500157538;6859.897101543581;7008.194057683228;7051.929480705333;7063.187733410518;6956.339147780953;6956.965215173892;6958.686859091252;7060.470464715064;7061.2585678505075;6548.0832683423405;6613.10723052401;6630.734770609121;6631.867362652816;6639.867202655823;4641.327007583949;4731.924249238023;4853.781579828987;4891.779869905791;4897.2654101885;4680.274557443602;4814.109389762905;4823.879403014953;4848.175810112219;4935.777889995031 11:03:40 INFO - PROCESS | 15784 | |4;prototype.html;297.89126968656444;300.7338505422701;302.81679583851775;307.9168624471391;308.92585779412934;4870.4398994115645;4879.804807807684;4893.41279046515;4900.166971614825;4925.138100832353;4823.8794030149265;4835.830745923893;4850.34520339754;4853.830115945942;4863.975680121604;3622.7826330420194;3724.29238444696;3743.794091324976;3834.118152824852;3852.669135173222;3772.792496412696;3838.558565764945;3838.5777564467885;3857.4213867919757;3864.401017842225;3814.8255494368223;3814.866479673212;3828.406596977473;3839.577646458887;3852.152526444178;3651.9817400912957;3735.9452301234346;3821.5605205401457;3831.4444405561317;3843.9231215375817;3392.4063288924585;3393.5588373511287;3398.065531978701;3398.3203359327986;3414.4536874100027;4779.872956534344;4783.760811959388;4787.257975013878;4793.9280910786365;4796.400449943757;4248.171606536726;4393.6045755881805;4400.823967041314;4402.889927751832;4409.691321607489;5013.423456302536;5058.949410505885;5062;5096.1846104623455;5116.362763915548;3718.200586873808;3721.962780372216;3730.1047748540427;3736.7757934524016;3743.026813028632;5080;5298.072837253504;5317.580500872133;5366.195070739382;5366.838994830161;3793.374093274634;3808.9238215236096;3809.104860357814;3814.6376094271;3816.4084566892175;3791.469194312798;3815.523059617548;3819.3316169670197;3831.750936189139;3833.5783063862955;4323.156984388014;4337.501187363494;4351.586599273064;4358.411614432074;4371.322445021026;4819.783109760069;5107.87230319245;5120.308758317579;5121.8719532012;5141.511556402136;1286.7297867447753;1293.4502836294726;1294.501616877509;1298.623399214236;1299.2594221293962;813.7477382011477;813.983720325602;815.3477218225396;862.7498025572639;882.6601758323092;4421.712588681726;4422.049259409178;4431.556844315607;4433.492612511697;4479;5190.6107041971245;5190.974045129826;5213.191955246943;5249.527542521115;5251.426800867547;4246.789664945476;4369.126174764996;4405.669574781904;4405.757683327448;4419.646428285794;2744.245332533529;2761.4477104579164;2779.277387879166;2832.5412412607525;2837.7230246388795;4934.519644106826;4977.776000079933;4982.526659967298;5021.874453138627;5023.271625614266;5302.549283310885;5326.6537675050995;5434.64674796137;5458.4814442627885;5474.151506516497;4994.275830004629;4997.650634328711;5009.497150854656;5018.899622007612;5021.84934451967;5243.528082472596;5246.422893481637;5276.34045744282;5309.734513274244;5322.9467705324;4909.26361045846;5186.507281808223;5190;5195.584353251656;5213.374395072616;4972.950270497248;4986.825461108844;4986.975065124796;5000.724960127082;5003.949960500494;3698.7595806272507;3700.944485832661;3706.1105334720014;3711.498947642142;3717.8698745544857;5153.093355458504;5318.920216196838;5333.200019997032;5338.679679219259;5366.2487251784005;5133.460986596503;5149.639525233198;5150.562202212854;5151.278820965143;5162.793488260578;5105.744712764421;5112.693238405707;5119.436861945109;5125.897482050413;5147.176451767699;4932.4081110267;5072.137736584716;5074.467180946095;5093.974530127326;5093.974530127474;4944.975275123601;5033.169527028;5168.457311982338;5178.922316165336;5185.896282074413;5031.798728050983;5038.370203724535;5040.974795126148;5042.865355295029;5047.419546752024 11:03:40 INFO - PROCESS | 15784 | |5;yui.html;609.0802887639662;609.7530500147441;642.0882347067164;699.3845416033889;735.9043324367832;12998.41507132179;13900.652483687913;13942.302884855755;13951.232682202475;13972.720545589094;13007.219566825974;13780.724385512309;14270.928645356784;14301.070430422014;14844.55466336009;779.7231982646164;795.5028107432854;798.9400794940402;799.1050023973129;800.4076983032572;625.4058644287921;759.6050053971959;788.207851109634;791.639803889229;792.0851416613821;832.2052439919893;836.021854430315;836.6862426590029;836.7991681996308;837.2381133168817;645.5577929118568;825.4593241426875;825.8719898415756;825.9463134896213;826.5784449930549;583.4894467341077;602.6956387024525;603.414687752879;603.4177019176472;603.809799913026;12717.809232861515;12773.361331933365;12780.808287875689;12796;12860.935695321557;12332.198407103599;12944.352782360938;13047.54333598329;13052.347382630925;13115.737685246337;11825.172237943347;12009.519619215222;12070.27578345302;12134.817977730341;12513.874861251363;4089.488813898263;4148.979255103705;4194;4201.369794530814;4312.460942382202;45037.324440133096;45577.088458230646;45612.543874560826;45824.312635310496;45958.77020614909;9886.802263954825;9895.208383329316;10226.846597301046;10372;10657.147428205724;17812.287508499514;18360.908195459204;18373;19168.71246931297;19201.423957281302;6877.89683154753;6959.851624482005;6965;6991.825204369829;7070.611116388545;3239.4330992076293;3333.4333163362285;3388.4917262410345;3523.1016090896655;3541.2386336937166;2848.7293707097792;2997.505411607104;2997.775166862494;3000.8949686760857;3003.294225856922;466.477545149428;470.927391289329;476.2522839142513;480.0926249388658;486.8077109541711;406.2362758014972;426.49460389438616;437.0494175168995;482.14178761804044;497.9078870408986;6783.728650854009;6997.148171109733;7075.92924070763;7126.928730712731;7325.963370183222;422.7167797575632;424.0987900710989;493.77286448233497;497.7536119620811;504.5559907281642;3526.7354948378975;3554.644535546425;3623.221007483351;3648.689861361761;3712.2389910068373;50890.49109508932;51291.23063154056;51457.742711286206;51493.227601586004;79378.20621793708;74867.62566187134;77415.61292193503;79283.60358198172;79422.20577794264;84032;54492.45507544953;66658.00077993004;68394.65802670954;69064.6546767273;70542;7047.982362704014;7068.858622827617;7115.217326094022;7134.821629459305;7157.85684286301;41126;42009;42348;42766.8215470508;43216.35175472307;51468.74265628648;61111.69444152751;62555;62981.370186299384;63116;9093.54532273397;9195.126462986005;9200;9221.49281789508;9546.093121153479;10102;10381.273310868166;10579.841302380624;10766.46167691628;10955.452227388758;8239.823489274393;9497.335186536877;9949.353292035994;10997.829833090595;11692.824607630722;10278.229132814919;10422.947885260524;10486.632967846088;10494.47527623631;11011.669649910515;11321.264117832314;11509.366984815915;11516.769664606829;11850.525978960744;12005.459754311252;8677.826443471222;8718.607662655322;8755.392235181318;8874.600642970952;9165.450072995642;9007.549622518978;9459.952700236454;9653;9657.979568896923;9764.462954537568 11:03:40 INFO - PROCESS | 15784 | __end_tp_report 11:03:40 INFO - PROCESS | 15784 | __start_cc_report 11:03:40 INFO - PROCESS | 15784 | _x_x_mozilla_cycle_collect,907 11:03:40 INFO - PROCESS | 15784 | __end_cc_report 11:03:40 INFO - PROCESS | 15784 | __startTimestamp1468433019998__endTimestamp 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | ------- Summary: start ------- 11:03:40 INFO - PROCESS | 15784 | Number of tests: 6 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | [#0] dojo.html Cycles:165 Average:4532.86 Median:4683.74 stddev:478.90 (10.2%) stddev-sans-first:454.69 11:03:40 INFO - PROCESS | 15784 | Values: 2560.8 2581.0 2583.7 2619.1 2623.5 4443.9 4498.6 4582.6 4590.0 4603.2 4525.6 4561.0 4586.4 4610.2 4632.6 4192.9 4198.3 4206.8 4266.5 4289.4 4224.3 4261.7 4288.4 4303.3 4304.0 4084.8 4115.7 4120.5 4246.3 4282.5 4157.8 4174.9 4178.1 4182.1 4185.2 4136.5 4164.4 4191.2 4213.5 4236.0 4590.5 4642.8 4644.1 4654.0 4690.2 4684.5 4974.2 4975.0 4993.2 4994.1 4826.8 4836.5 4869.4 4877.3 4895.3 4548.1 4566.4 4598.2 4603.0 4609.7 4831.7 4957.8 5025.0 5026.8 5032.1 4838.6 4862.0 4887.6 4902.8 4907.0 4865.8 4895.1 4936.9 4937.1 4937.2 4680.8 4695.5 4815.1 4857.0 4869.2 4820.3 4827.3 4836.1 4858.5 4890.9 4104.0 4113.8 4124.5 4125.4 4152.7 3523.6 3526.0 3555.7 3609.3 3618.1 4214.0 4226.5 4241.3 4288.0 4290.9 4941.2 4947.7 4951.7 4961.1 5005.2 4101.7 4161.4 4219.8 4234.9 4266.1 4356.0 4384.7 4386.0 4402.8 4412.8 4638.1 4651.6 4659.2 4686.6 4696.6 4718.0 4910.1 4910.9 4921.2 4924.7 4665.8 4665.9 4670.3 4690.2 4733.8 4880.7 4894.5 4899.3 4900.6 4928.1 4692.9 4883.5 4912.3 4961.7 4992.5 4776.6 4787.4 4796.3 4832.6 4846.8 4818.8 4824.1 4833.7 4845.8 4898.6 4530.2 4683.7 4742.4 4742.8 4750.0 4809.4 4813.5 4828.5 4834.5 4873.1 4710.9 4711.8 4721.2 4724.7 4774.5 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | [#1] ext.html Cycles:180 Average:46543.69 Median:34851.50 stddev:82795.60 (237.6%) stddev-sans-first:82955.90 11:03:40 INFO - PROCESS | 15784 | Values: 568.0 568.2 576.4 580.2 581.3 26894.7 37966.6 39170.8 39220.0 42767.4 38979.0 39396.6 39418.2 39427.6 39447.0 7571.4 7922.3 8075.3 8081.4 8090.1 7668.0 7761.0 7765.3 10040.2 10352.8 10425.9 10465.7 10469.9 10491.1 10497.6 10271.1 10313.6 10321.4 10341.6 10345.9 7479.1 7732.3 7748.4 9785.4 10196.5 37448.0 37754.2 37820.6 37831.8 37849.4 2867.8 2869.8 2943.9 3028.2 3430.0 27741.2 27815.7 27988.7 28310.6 28747.4 2977.5 2981.9 2983.1 3008.8 3054.9 254375.0 255510.9 256628.0 256838.0 256930.0 50001.7 50204.0 50270.2 50281.0 50291.5 53264.7 53326.0 53400.2 53406.0 53553.5 14299.9 14672.1 14685.2 14686.7 14687.3 10028.0 10028.1 10033.6 10072.9 10274.2 14477.2 14829.3 14987.0 15012.5 15231.8 5585.1 5608.5 5641.6 5659.8 5738.0 834.9 911.7 941.8 962.6 975.5 26275.6 26842.3 27425.9 27627.9 27775.7 928.5 932.4 943.9 991.9 1023.0 13805.4 14407.6 14500.9 14760.9 14779.0 365646.0 369243.0 369282.0 370689.0 370925.0 46797.3 46995.0 47025.0 47046.5 47090.5 1075.1 1099.5 1160.7 1180.5 1193.7 25865.5 28332.2 28648.3 28719.4 29192.3 40155.4 40621.6 40963.8 40975.0 41019.8 308710.0 308745.0 310517.0 310613.0 312884.0 30188.2 34750.0 34953.0 35589.0 35973.3 39678.4 40072.8 40310.6 40843.0 41145.6 35206.8 35286.8 35319.1 35837.6 36038.0 35334.6 35897.3 35960.3 35998.5 36221.0 33706.5 34248.3 34445.7 34690.1 35044.0 29763.1 30979.4 31063.2 31255.5 31295.2 23753.5 24003.9 24363.7 24407.5 24433.0 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | [#2] jquery.html Cycles:180 Average:23251.05 Median:432.51 stddev:62456.58 (14440.5%) stddev-sans-first:62608.11 11:03:40 INFO - PROCESS | 15784 | Values: 346.8 364.4 376.9 377.3 399.2 13177.8 13616.3 16383.6 17595.6 17619.8 16242.4 17653.1 17669.2 17676.7 17695.6 4998.0 5131.6 5175.6 5189.9 5195.2 3759.2 5858.2 6145.2 6153.4 6257.2 6034.2 6067.2 6160.2 6199.2 6205.2 6027.7 6083.8 6100.9 6143.0 6147.7 4743.5 5064.7 5073.1 5251.2 5257.5 12473.4 12494.9 12500.6 12643.9 19271.3 1711.5 1713.7 1885.9 1969.9 1986.3 9142.2 9492.8 9669.7 9841.7 12854.3 1623.1 1697.9 1699.0 1701.4 1734.7 62439.7 66081.3 68771.3 70868.9 70922.6 8553.8 8795.1 9182.7 9286.8 10314.9 12044.3 12050.0 12060.5 12122.2 12141.3 6981.5 7137.1 7163.4 7164.5 7210.2 6958.2 6993.7 7106.5 7140.0 7142.8 3812.9 3825.3 3826.6 3860.5 3924.9 1566.9 1694.0 1703.7 1726.1 1756.3 714.5 830.2 835.8 867.3 879.4 10814.8 11060.8 11122.8 11303.6 11349.7 392.9 393.0 401.4 405.4 415.8 9552.4 10364.5 10495.2 10812.6 10954.1 366269.0 376025.0 381726.0 381801.0 382225.0 41307.4 66476.3 81238.6 81578.6 81597.0 426.9 431.8 433.2 433.8 435.0 10454.8 10646.6 10708.1 10792.2 10832.0 37599.2 38429.8 38618.0 38702.7 38836.8 51849.0 52670.5 54056.0 54085.7 54165.5 7326.3 7357.6 7481.9 7641.6 7722.0 10607.7 11024.6 11152.9 11153.4 11346.8 9476.8 9750.1 9860.3 9895.0 10049.6 9722.4 9785.3 9800.0 9871.7 9934.1 9782.6 9946.6 10025.5 10071.5 10150.3 7521.7 7591.6 7622.8 7627.3 7756.4 7662.8 9624.6 9837.4 10063.8 10071.2 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | [#3] mootools.html Cycles:180 Average:5166.42 Median:5429.07 stddev:2882.90 (53.1%) stddev-sans-first:2876.99 11:03:40 INFO - PROCESS | 15784 | Values: 1385.9 1437.1 1535.9 1714.5 1734.9 6607.5 6844.9 7653.8 8095.5 8104.8 7649.1 7960.8 7963.5 8043.8 8113.7 2118.9 2143.7 2144.5 2145.8 2147.3 1840.6 1892.0 1894.5 1915.5 2200.8 2175.7 2251.4 2252.5 2261.2 2267.0 2151.9 2157.0 2168.2 2267.8 2270.4 2208.0 2212.9 2215.2 2215.3 2235.5 8100.0 8162.8 8164.7 8168.1 8168.6 4450.4 4606.8 4610.1 4613.2 4613.8 2715.1 2733.7 2785.9 2793.9 2798.0 807.2 813.5 822.3 845.8 853.4 10980.9 11037.6 11040.8 11049.3 11051.2 4032.5 4225.9 4316.8 4316.8 4321.5 9440.5 9466.5 9491.1 9491.5 9501.2 4606.5 4617.4 4618.5 4619.9 4621.9 4069.7 4145.9 4152.1 4161.1 4165.5 3298.4 3469.0 3527.0 3545.8 3713.0 1189.9 1219.0 1228.4 1228.9 1238.8 802.4 851.9 854.4 861.5 863.9 5395.2 5462.9 5556.1 5588.6 5596.6 892.3 896.3 901.9 902.3 929.6 3760.2 3763.9 3772.9 3785.9 3833.7 9018.4 9167.5 9230.3 9301.1 9313.9 9226.8 9244.6 9249.7 9255.2 9259.8 7067.8 7072.7 7146.4 7149.2 7152.4 5224.4 5241.5 5296.6 5356.8 5362.9 8375.3 8721.4 8814.8 8825.2 8832.8 8631.4 8825.5 8834.4 8894.8 9028.6 6601.7 6609.4 6659.1 6682.3 6687.6 6538.6 7376.6 7658.5 7676.8 7820.3 6663.6 6859.9 7008.2 7051.9 7063.2 6956.3 6957.0 6958.7 7060.5 7061.3 6548.1 6613.1 6630.7 6631.9 6639.9 4641.3 4731.9 4853.8 4891.8 4897.3 4680.3 4814.1 4823.9 4848.2 4935.8 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | [#4] prototype.html Cycles:180 Average:4254.22 Median:4867.21 stddev:1235.52 (25.4%) stddev-sans-first:1202.78 11:03:40 INFO - PROCESS | 15784 | Values: 297.9 300.7 302.8 307.9 308.9 4870.4 4879.8 4893.4 4900.2 4925.1 4823.9 4835.8 4850.3 4853.8 4864.0 3622.8 3724.3 3743.8 3834.1 3852.7 3772.8 3838.6 3838.6 3857.4 3864.4 3814.8 3814.9 3828.4 3839.6 3852.2 3652.0 3735.9 3821.6 3831.4 3843.9 3392.4 3393.6 3398.1 3398.3 3414.5 4779.9 4783.8 4787.3 4793.9 4796.4 4248.2 4393.6 4400.8 4402.9 4409.7 5013.4 5058.9 5062.0 5096.2 5116.4 3718.2 3722.0 3730.1 3736.8 3743.0 5080.0 5298.1 5317.6 5366.2 5366.8 3793.4 3808.9 3809.1 3814.6 3816.4 3791.5 3815.5 3819.3 3831.8 3833.6 4323.2 4337.5 4351.6 4358.4 4371.3 4819.8 5107.9 5120.3 5121.9 5141.5 1286.7 1293.5 1294.5 1298.6 1299.3 813.7 814.0 815.3 862.7 882.7 4421.7 4422.0 4431.6 4433.5 4479.0 5190.6 5191.0 5213.2 5249.5 5251.4 4246.8 4369.1 4405.7 4405.8 4419.6 2744.2 2761.4 2779.3 2832.5 2837.7 4934.5 4977.8 4982.5 5021.9 5023.3 5302.5 5326.7 5434.6 5458.5 5474.2 4994.3 4997.7 5009.5 5018.9 5021.8 5243.5 5246.4 5276.3 5309.7 5322.9 4909.3 5186.5 5190.0 5195.6 5213.4 4973.0 4986.8 4987.0 5000.7 5003.9 3698.8 3700.9 3706.1 3711.5 3717.9 5153.1 5318.9 5333.2 5338.7 5366.2 5133.5 5149.6 5150.6 5151.3 5162.8 5105.7 5112.7 5119.4 5125.9 5147.2 4932.4 5072.1 5074.5 5094.0 5094.0 4945.0 5033.2 5168.5 5178.9 5185.9 5031.8 5038.4 5041.0 5042.9 5047.4 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - PROCESS | 15784 | [#5] yui.html Cycles:180 Average:15439.18 Median:490.29 stddev:20572.85 (4196.1%) stddev-sans-first:20600.43 11:03:40 INFO - PROCESS | 15784 | Values: 609.1 609.8 642.1 699.4 735.9 12998.4 13900.7 13942.3 13951.2 13972.7 13007.2 13780.7 14270.9 14301.1 14844.6 779.7 795.5 798.9 799.1 800.4 625.4 759.6 788.2 791.6 792.1 832.2 836.0 836.7 836.8 837.2 645.6 825.5 825.9 825.9 826.6 583.5 602.7 603.4 603.4 603.8 12717.8 12773.4 12780.8 12796.0 12860.9 12332.2 12944.4 13047.5 13052.3 13115.7 11825.2 12009.5 12070.3 12134.8 12513.9 4089.5 4149.0 4194.0 4201.4 4312.5 45037.3 45577.1 45612.5 45824.3 45958.8 9886.8 9895.2 10226.8 10372.0 10657.1 17812.3 18360.9 18373.0 19168.7 19201.4 6877.9 6959.9 6965.0 6991.8 7070.6 3239.4 3333.4 3388.5 3523.1 3541.2 2848.7 2997.5 2997.8 3000.9 3003.3 466.5 470.9 476.3 480.1 486.8 406.2 426.5 437.0 482.1 497.9 6783.7 6997.1 7075.9 7126.9 7326.0 422.7 424.1 493.8 497.8 504.6 3526.7 3554.6 3623.2 3648.7 3712.2 50890.5 51291.2 51457.7 51493.2 79378.2 74867.6 77415.6 79283.6 79422.2 84032.0 54492.5 66658.0 68394.7 69064.7 70542.0 7048.0 7068.9 7115.2 7134.8 7157.9 41126.0 42009.0 42348.0 42766.8 43216.4 51468.7 61111.7 62555.0 62981.4 63116.0 9093.5 9195.1 9200.0 9221.5 9546.1 10102.0 10381.3 10579.8 10766.5 10955.5 8239.8 9497.3 9949.4 10997.8 11692.8 10278.2 10422.9 10486.6 10494.5 11011.7 11321.3 11509.4 11516.8 11850.5 12005.5 8677.8 8718.6 8755.4 8874.6 9165.5 9007.5 9460.0 9653.0 9658.0 9764.5 11:03:40 INFO - PROCESS | 15784 | -------- Summary: end -------- 11:03:40 INFO - PROCESS | 15784 | 11:03:40 INFO - TEST-INFO | 15784: exit 0 11:03:40 INFO - TEST-OK | dromaeo_css | took 1119377ms 11:03:40 INFO - TEST-START | kraken 11:03:40 INFO - operating with platform_type : linux_ 11:03:40 INFO - Initialising browser for kraken test... 11:03:40 INFO - TEST-INFO | started process 15973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXiGWl/profile http://localhost:33898/getInfo.html) 11:03:45 INFO - PROCESS | 15973 | __metrics Screen width/height:1600/1200 11:03:45 INFO - PROCESS | 15973 | colorDepth:24 11:03:45 INFO - PROCESS | 15973 | Browser inner width/height: 1024/697 11:03:45 INFO - PROCESS | 15973 | __metrics 11:03:46 INFO - PROCESS | 15973 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:03:46 INFO - PROCESS | 15973 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:03:47 INFO - TEST-INFO | 15973: exit 0 11:03:47 INFO - Browser initialized. 11:03:47 INFO - Running cycle 1/1 for kraken test... 11:03:47 INFO - TEST-INFO | started process 16053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXiGWl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:59 INFO - PROCESS | 16053 | RSS: Main: 159223808 11:03:59 INFO - PROCESS | 16053 | 11:04:01 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33898/tests/kraken/driver.html?testName=audio-beat-detection) 11:04:02 INFO - PROCESS | 16053 | RSS: Main: 216973312 11:04:02 INFO - PROCESS | 16053 | 11:04:05 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33898/tests/kraken/driver.html?testName=audio-dft) 11:04:06 INFO - PROCESS | 16053 | RSS: Main: 202964992 11:04:06 INFO - PROCESS | 16053 | 11:04:09 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33898/tests/kraken/driver.html?testName=audio-fft) 11:04:09 INFO - PROCESS | 16053 | RSS: Main: 271167488 11:04:09 INFO - PROCESS | 16053 | 11:04:12 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33898/tests/kraken/driver.html?testName=audio-oscillator) 11:04:12 INFO - PROCESS | 16053 | RSS: Main: 181571584 11:04:12 INFO - PROCESS | 16053 | 11:04:14 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:04:15 INFO - PROCESS | 16053 | RSS: Main: 186241024 11:04:15 INFO - PROCESS | 16053 | 11:04:18 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33898/tests/kraken/driver.html?testName=imaging-darkroom) 11:04:19 INFO - PROCESS | 16053 | RSS: Main: 222044160 11:04:19 INFO - PROCESS | 16053 | 11:04:22 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33898/tests/kraken/driver.html?testName=imaging-desaturate) 11:04:23 INFO - PROCESS | 16053 | RSS: Main: 217743360 11:04:23 INFO - PROCESS | 16053 | 11:04:26 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33898/tests/kraken/driver.html?testName=json-parse-financial) 11:04:26 INFO - PROCESS | 16053 | RSS: Main: 220971008 11:04:26 INFO - PROCESS | 16053 | 11:04:28 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:04:29 INFO - PROCESS | 16053 | RSS: Main: 207642624 11:04:29 INFO - PROCESS | 16053 | 11:04:31 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:04:31 INFO - PROCESS | 16053 | RSS: Main: 212914176 11:04:31 INFO - PROCESS | 16053 | 11:04:33 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:04:34 INFO - PROCESS | 16053 | RSS: Main: 210550784 11:04:34 INFO - PROCESS | 16053 | 11:04:37 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:04:37 INFO - PROCESS | 16053 | RSS: Main: 226836480 11:04:37 INFO - PROCESS | 16053 | 11:04:40 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:04:41 INFO - PROCESS | 16053 | RSS: Main: 225218560 11:04:41 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:33898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33898/tests/kraken/driver.html?testName=ai-astar) 11:04:43 INFO - PROCESS | 16053 | RSS: Main: 268132352 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | __start_tp_report 11:04:43 INFO - PROCESS | 16053 | _x_x_mozilla_page_load 11:04:43 INFO - PROCESS | 16053 | _x_x_mozilla_page_load_details 11:04:43 INFO - PROCESS | 16053 | |i|pagename|runs| 11:04:43 INFO - PROCESS | 16053 | |0;ai-astar;104;115;115;115;114;114;113;114;114;113 11:04:43 INFO - PROCESS | 16053 | |1;audio-beat-detection;144;123;123;192;125;128;143;122;158;127 11:04:43 INFO - PROCESS | 16053 | |2;audio-dft;161;162;160;161;161;163;160;162;163;162 11:04:43 INFO - PROCESS | 16053 | |3;audio-fft;74;76;77;119;78;77;76;74;112;75 11:04:43 INFO - PROCESS | 16053 | |4;audio-oscillator;85;86;124;85;85;85;114;85;84;125 11:04:43 INFO - PROCESS | 16053 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;117;117 11:04:43 INFO - PROCESS | 16053 | |6;imaging-darkroom;148;147;147;146;148;146;146;146;147;145 11:04:43 INFO - PROCESS | 16053 | |7;imaging-desaturate;95;95;95;94;96;96;95;95;95;95 11:04:43 INFO - PROCESS | 16053 | |8;json-parse-financial;63;63;64;64;64;65;64;65;64;64 11:04:43 INFO - PROCESS | 16053 | |9;json-stringify-tinderbox;67;66;67;66;67;66;67;67;66;67 11:04:43 INFO - PROCESS | 16053 | |10;stanford-crypto-aes;87;81;78;78;78;79;78;80;78;79 11:04:43 INFO - PROCESS | 16053 | |11;stanford-crypto-ccm;137;128;127;129;140;135;129;146;170;129 11:04:43 INFO - PROCESS | 16053 | |12;stanford-crypto-pbkdf2;169;167;163;174;163;166;164;166;165;165 11:04:43 INFO - PROCESS | 16053 | |13;stanford-crypto-sha256-iterative;66;68;66;66;66;65;66;65;65;66 11:04:43 INFO - PROCESS | 16053 | __end_tp_report 11:04:43 INFO - PROCESS | 16053 | __start_cc_report 11:04:43 INFO - PROCESS | 16053 | _x_x_mozilla_cycle_collect,1916 11:04:43 INFO - PROCESS | 16053 | __end_cc_report 11:04:43 INFO - PROCESS | 16053 | __startTimestamp1468433083363__endTimestamp 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | ------- Summary: start ------- 11:04:43 INFO - PROCESS | 16053 | Number of tests: 14 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.28 (2.9%) stddev-sans-first:0.78 11:04:43 INFO - PROCESS | 16053 | Values: 104.0 115.0 115.0 115.0 114.0 114.0 113.0 114.0 114.0 113.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:135.50 stddev:22.29 (16.4%) stddev-sans-first:23.55 11:04:43 INFO - PROCESS | 16053 | Values: 144.0 123.0 123.0 192.0 125.0 128.0 143.0 122.0 158.0 127.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 11:04:43 INFO - PROCESS | 16053 | Values: 161.0 162.0 160.0 161.0 161.0 163.0 160.0 162.0 163.0 162.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:16.84 (22.2%) stddev-sans-first:17.48 11:04:43 INFO - PROCESS | 16053 | Values: 74.0 76.0 77.0 119.0 78.0 77.0 76.0 74.0 112.0 75.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:17.63 (20.7%) stddev-sans-first:18.26 11:04:43 INFO - PROCESS | 16053 | Values: 85.0 86.0 124.0 85.0 85.0 85.0 114.0 85.0 84.0 125.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:04:43 INFO - PROCESS | 16053 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:0.88 11:04:43 INFO - PROCESS | 16053 | Values: 148.0 147.0 147.0 146.0 148.0 146.0 146.0 146.0 147.0 145.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:04:43 INFO - PROCESS | 16053 | Values: 95.0 95.0 95.0 94.0 96.0 96.0 95.0 95.0 95.0 95.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 11:04:43 INFO - PROCESS | 16053 | Values: 63.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 64.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:04:43 INFO - PROCESS | 16053 | Values: 67.0 66.0 67.0 66.0 67.0 66.0 67.0 67.0 66.0 67.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.80 (3.5%) stddev-sans-first:1.09 11:04:43 INFO - PROCESS | 16053 | Values: 87.0 81.0 78.0 78.0 78.0 79.0 78.0 80.0 78.0 79.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:136.00 stddev:13.15 (9.7%) stddev-sans-first:13.95 11:04:43 INFO - PROCESS | 16053 | Values: 137.0 128.0 127.0 129.0 140.0 135.0 129.0 146.0 170.0 129.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.00 stddev:3.29 (2.0%) stddev-sans-first:3.33 11:04:43 INFO - PROCESS | 16053 | Values: 169.0 167.0 163.0 174.0 163.0 166.0 164.0 166.0 165.0 165.0 11:04:43 INFO - PROCESS | 16053 | 11:04:43 INFO - PROCESS | 16053 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 11:04:43 INFO - PROCESS | 16053 | Values: 66.0 68.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 66.0 11:04:43 INFO - PROCESS | 16053 | -------- Summary: end -------- 11:04:43 INFO - PROCESS | 16053 | 11:04:44 INFO - TEST-INFO | 16053: exit 0 11:04:44 INFO - TEST-OK | kraken | took 63599ms 11:04:44 INFO - SUITE-END | took 1182s 11:04:44 INFO - Completed test suite (00:19:43) 11:04:44 INFO - javascript benchmark 11:04:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2560.8079394045444, 2580.9870950645245, 2583.728708485608, 2619.09641173795, 2623.4884197581455, 4443.933340999887, 4498.572635599621, 4582.610478109361, 4589.954100458998, 4603.171429142753, 4525.570070843273, 4561.042181141956, 4586.403767510227, 4610.239310513761, 4632.583067523922, 4192.874213773592, 4198.265303571863, 4206.789660516977, 4266.466691663542, 4289.442372491588, 4224.324108142698, 4261.722988005769, 4288.442502474674, 4303.26844436445, 4304.010077682135, 4084.7957602120073, 4115.650169735576, 4120.526139493966, 4246.278132717445, 4282.464691913527, 4157.750534967911, 4174.895627609304, 4178.101708132735, 4182.121754431573, 4185.183889141618, 4136.524299705542, 4164.437800896871, 4191.203671302443, 4213.494380674308, 4236.025714085747, 4590.540945905383, 4642.79107440166, 4644.117617652635, 4653.95346046542, 4690.1557719610455, 4684.508126646721, 4974.204127339608, 4974.950250497485, 4993.201087825967, 4994.076095922266, 4826.758662066918, 4836.46798852126, 4869.440014398318, 4877.341558889575, 4895.265710143472, 4548.090381923563, 4566.360709500673, 4598.195315819752, 4602.976985115053, 4609.700369476041, 4831.661783675179, 4957.752112394366, 5025.020121076428, 5026.824061157842, 5032.0690672225755, 4838.564529192389, 4861.975690121527, 4887.560119589183, 4902.828401005948, 4907.018596280758, 4865.756712164378, 4895.094407534618, 4936.851894443173, 4937.136001199776, 4937.210046392632, 4680.765961701902, 4695.5069717679835, 4815.133276010351, 4857.028594281087, 4869.220924652039, 4820.25286080658, 4827.324174615556, 4836.056968891033, 4858.5384388483035, 4890.926636100461, 4103.97948010258, 4113.794310284534, 4124.546299907008, 4125.401816736617, 4152.667786577066, 3523.5947865995226, 3525.9823700881843, 3555.6977656898935, 3609.296187243515, 3618.0773902654655, 4214.0, 4226.535081141072, 4241.300185469425, 4288.035192081819, 4290.935635965463, 4941.2341087130835, 4947.6536642434685, 4951.678140920829, 4961.131801934647, 5005.224190250517, 4101.651359634405, 4161.417401563723, 4219.810108545123, 4234.894127646833, 4266.0827921996915, 4356.0, 4384.7369157850635, 4386.0, 4402.779861006937, 4412.779361031936, 4638.1187574360765, 4651.627869770478, 4659.161350956792, 4686.625069994392, 4696.600788932979, 4718.009218064245, 4910.091633047898, 4910.8772280693265, 4921.188003979447, 4924.704517728947, 4665.813367465264, 4665.86002419928, 4670.276107203389, 4690.1792186366565, 4733.8343157990685, 4880.658353915192, 4894.486078961801, 4899.31409602663, 4900.558949694545, 4928.137575924271, 4692.859214223578, 4883.511648835088, 4912.336834527436, 4961.70229786214, 4992.450830408725, 4776.59398951093, 4787.42550893895, 4796.304535842353, 4832.613390928787, 4846.781894814671, 4818.831340903192, 4824.0834241494, 4833.685810422452, 4845.8061677533915, 4898.632602554751, 4530.161920044802, 4683.742394168354, 4742.407199100113, 4742.834000809955, 4749.976250118727, 4809.374781278551, 4813.542713442217, 4828.5412885775795, 4834.468208497133, 4873.074115917964, 4710.858674239778, 4711.811527538997, 4721.197396442682, 4724.71651700899, 4774.546418090275], "value": 4502.357346084645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.9914801277979, 568.2215364950019, 576.3688760806915, 580.1993249315943, 581.2705055155781, 26894.73105268947, 37966.62033379665, 39170.8041459793, 39220.0, 42767.35848962268, 38979.0, 39396.60603393965, 39418.211635767264, 39427.605723942754, 39447.0, 7571.356434703057, 7922.3266022388025, 8075.273225409712, 8081.43429959903, 8090.110087890327, 7667.961660191719, 7761.0298712660915, 7765.301122898938, 10040.196784257241, 10352.79294414115, 10425.947870260676, 10465.73835654111, 10469.895301046969, 10491.108255798228, 10497.580096796119, 10271.075603195712, 10313.587456501731, 10321.380717156919, 10341.638042668508, 10345.896541034568, 7479.102507699056, 7732.3040926316335, 7748.380129589676, 9785.412875227508, 10196.54115564794, 37448.0, 37754.244915101546, 37820.62179378226, 37831.810840945895, 37849.43225851614, 2867.845370092902, 2869.8421586812715, 2943.9116826495024, 3028.242939265184, 3430.0, 27741.196822206493, 27815.721842781717, 27988.720112798816, 28310.575341369895, 28747.425051499064, 2977.456826376605, 2981.925451863699, 2983.075246673538, 3008.7893847430687, 3054.862531186102, 254375.0, 255510.94689792054, 256628.0, 256838.0, 256930.0, 50001.74999124981, 50204.0, 50270.24594631083, 50281.0, 50291.49708502941, 53264.73367633137, 53326.0, 53400.198997015075, 53406.0, 53553.464465355624, 14299.928500357431, 14672.119672819452, 14685.19231442281, 14686.706265874624, 14687.339069741887, 10028.047335503115, 10028.147607453448, 10033.598656053677, 10072.899271007343, 10274.22943279257, 14477.203753793643, 14829.332680029425, 14987.0, 15012.549623511311, 15231.847681523042, 5585.134304182777, 5608.49523542875, 5641.633293835887, 5659.773609055674, 5737.971310143506, 834.8747687846871, 911.6854685133618, 941.8257622339889, 962.6149540183983, 975.5219942228257, 26275.605865912028, 26842.32894177622, 27425.86287068552, 27627.86186069057, 27775.722242777716, 928.5125309212717, 932.38462614674, 943.9197668198143, 991.945443000642, 1022.9846552301722, 13805.378757955916, 14407.631275028856, 14500.927495362455, 14760.926195368955, 14778.965472416827, 365646.0, 369243.0, 369282.0, 370689.0, 370925.0, 46797.29804052942, 46995.0, 47025.0, 47046.52953470421, 47090.5290947093, 1075.1452595186845, 1099.5381939585393, 1160.6634076117832, 1180.4864883775585, 1193.6956076200513, 25865.482690346464, 28332.15003549897, 28648.283792905346, 28719.42561148807, 29192.27019324449, 40155.39766903557, 40621.593784061784, 40963.7951810239, 40975.0, 41019.79490102531, 308710.0, 308745.0, 310517.0, 310613.0, 312884.0, 30188.24529386783, 34750.0, 34953.0, 35589.0, 35973.28053438864, 39678.404823927085, 40072.79963600163, 40310.596894030685, 40843.0, 41145.58854411537, 35206.82396588001, 35286.823565882005, 35319.11702207466, 35837.64162358343, 36038.0, 35334.646653533135, 35897.28205435929, 35960.28079438449, 35998.4600231002, 36221.0, 33706.49440258349, 34248.31503369869, 34445.655543445246, 34690.132746681535, 35044.0, 29763.107106786832, 30979.380412391176, 31063.223419414695, 31255.53116703297, 31295.21761955878, 23753.52492950166, 24003.879980599984, 24363.65999869953, 24407.51184976326, 24433.0], "value": 17444.525779013846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.78970393327296, 364.4387643029734, 376.905773556611, 377.2793963529658, 399.1737104194317, 13177.802332965, 13616.251106189167, 16383.59041023975, 17595.56011099723, 17619.823801761977, 16242.350305987746, 17653.117344132774, 17669.20488578014, 17676.734848977274, 17695.646087078283, 4997.975010124954, 5131.615128865331, 5175.58595312376, 5189.870253243661, 5195.168772996321, 3759.191773768639, 5858.1505681676135, 6145.170401995741, 6153.35389784073, 6257.186565746447, 6034.24571928509, 6067.211262535886, 6160.19917410736, 6199.225096862892, 6205.193324867761, 6027.698615069273, 6083.756649734005, 6100.938990610081, 6142.969285153546, 6147.661878596676, 4743.549362810562, 5064.670796398223, 5073.1122053640465, 5251.212318152269, 5257.526822585947, 12473.438695258736, 12494.937525312314, 12500.624981250578, 12643.873561264361, 19271.30201771753, 1711.5036639374566, 1713.6915355236054, 1885.8868467891832, 1969.8522610804248, 1986.2650819196845, 9142.222911052568, 9492.762680932963, 9669.661561845372, 9841.704748857546, 12854.293013884233, 1623.123513302827, 1697.949061528156, 1699.0315520153517, 1701.387500499819, 1734.6877562038828, 62439.68780156116, 66081.339186608, 68771.31228687699, 70868.93696594606, 70922.64538677274, 8553.786155346043, 8795.076516965626, 9182.67860624875, 9286.767830804283, 10314.896851031393, 12044.337561434206, 12050.035997120385, 12060.457279422448, 12122.212056216318, 12141.271523708605, 6981.511294209458, 7137.10786151731, 7163.3552980232025, 7164.498485106097, 7210.206877243499, 6958.199807022257, 6993.6503174841055, 7106.502544821917, 7140.0, 7142.821434463255, 3812.8856134316015, 3825.2731980923536, 3826.6364695354455, 3860.4595356650093, 3924.8626298080003, 1566.8824838137186, 1694.0259350873298, 1703.6848183085922, 1726.1369315342329, 1756.297481007607, 714.4784307455586, 830.2195935820309, 835.8370117827087, 867.2888231650113, 879.4107947675074, 10814.837777433344, 11060.834087488694, 11122.777544449227, 11303.561526125613, 11349.716257093638, 392.8683890896582, 393.04686136119795, 401.3798681037804, 405.36965019395126, 415.77548124012696, 9552.37909535878, 10364.481775911174, 10495.212859035602, 10812.56749730002, 10954.123670106372, 366269.0, 376025.0, 381726.0, 381801.0, 382225.0, 41307.38038929419, 66476.33523664798, 81238.59380703059, 81578.59210703909, 81597.0, 426.88260728299343, 431.833744008559, 433.18561105122797, 433.7982837980354, 434.97172683775455, 10454.843177352193, 10646.627368042082, 10708.089812366035, 10792.190585705946, 10832.0, 37599.248015040095, 38429.80785096057, 38618.0, 38702.67783932973, 38836.805815970736, 51849.0, 52670.473295268086, 54056.0, 54085.72957135189, 54165.45834541762, 7326.3040011198855, 7357.632118393952, 7481.925180748123, 7641.579713115832, 7722.0, 10607.734806629896, 11024.559017639205, 11152.888471115184, 11153.386563739072, 11346.773064538827, 9476.810463790824, 9750.122488976027, 9860.265495558497, 9894.950525247616, 10049.598016079275, 9722.416655000723, 9785.31502794826, 9799.951000245239, 9871.654492092743, 9934.105930466292, 9782.608695652094, 9946.602135914482, 10025.498725063864, 10071.546780395047, 10150.289479736643, 7521.736739214101, 7591.620418978919, 7622.8094297643, 7627.275408836152, 7756.418268629763, 7662.770116896502, 9624.615015399586, 9837.360571562825, 10063.849042264519, 10071.194304455772], "value": 7518.102112136275, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.8822000129987, 1437.0874494695868, 1535.9308831102599, 1714.4513755598198, 1734.8698847586434, 6607.5044371672075, 6844.8973265401055, 7653.770386888388, 8095.473794203373, 8104.797380065501, 7649.082110146776, 7960.840783184332, 7963.522188668684, 8043.798905027377, 8113.716019939303, 2118.8728676279397, 2143.721316228888, 2144.4960434297927, 2145.7639659637425, 2147.2699282244034, 1840.6318736252736, 1892.0445175186512, 1894.4506093232947, 1915.549845786239, 2200.8129309008755, 2175.662772270293, 2251.4371407148215, 2252.538229662923, 2261.231181398324, 2266.954660906781, 2151.9031643576, 2157.018556556763, 2168.2302782512297, 2267.818574514035, 2270.375646697155, 2208.03950281628, 2212.8672279663274, 2215.2135991722866, 2215.324326080545, 2235.4523141830355, 8100.0, 8162.755117346489, 8164.67341306347, 8168.101508834024, 8168.632411541435, 4450.443694538183, 4606.792694328763, 4610.05493873755, 4613.192691279013, 4613.8154473821005, 2715.117586784283, 2733.7129601391766, 2785.8607069646437, 2793.8742756576003, 2798.048663454415, 807.2169995104739, 813.5118928642826, 822.3421262989644, 845.8392905347964, 853.4452605806214, 10980.945095274472, 11037.613683521118, 11040.834387484194, 11049.342598610272, 11051.17116216279, 4032.5362583303295, 4225.915481690349, 4316.762578058174, 4316.762578058237, 4321.503027151855, 9440.480773557383, 9466.526673666427, 9491.145796878314, 9491.47796871165, 9501.192398646193, 4606.539346065434, 4617.445906491243, 4618.468876079294, 4619.8845028873875, 4621.884452888705, 4069.694772892045, 4145.91708165841, 4152.148809494047, 4161.0845613964875, 4165.541790403053, 3298.373309071269, 3468.965310346864, 3526.9647303526635, 3545.840437180333, 3712.9628703712615, 1189.8517930197402, 1219.0491416694992, 1228.3858070964518, 1228.9262644241373, 1238.7859897300696, 802.3982013489882, 851.923326900582, 854.3592305770673, 861.4917198852708, 863.8661007543841, 5395.21769343443, 5462.918056229159, 5556.138798486241, 5588.552915766729, 5596.58025648078, 892.312919052326, 896.2561074308309, 901.8501410701277, 902.3142411767104, 929.6374413978554, 3760.2103558252525, 3763.8870833875026, 3772.86794962175, 3785.9242815144094, 3833.6549710526187, 9018.368714189945, 9167.541622918827, 9230.261579073793, 9301.069893010645, 9313.90686093144, 9226.769330766785, 9244.583993720298, 9249.676261330822, 9255.213306868991, 9259.76850578741, 7067.787966361017, 7072.68172932209, 7146.3568278855155, 7149.213586505481, 7152.392046675986, 5224.425313215619, 5241.528262456397, 5296.629235953446, 5356.758945847524, 5362.946370536245, 8375.32997360222, 8721.389502734748, 8814.779630509289, 8825.249853762502, 8832.779180520538, 8631.352648551509, 8825.514596697243, 8834.425762325429, 8894.822103557763, 9028.638854446011, 6601.735930562916, 6609.405153536205, 6659.101021362054, 6682.3317668232785, 6687.6321802301345, 6538.640374779433, 7376.557406555624, 7658.540487570764, 7676.846463070819, 7820.296173344426, 6663.633500157538, 6859.897101543581, 7008.194057683228, 7051.929480705333, 7063.187733410518, 6956.339147780953, 6956.965215173892, 6958.686859091252, 7060.470464715064, 7061.2585678505075, 6548.0832683423405, 6613.10723052401, 6630.734770609121, 6631.867362652816, 6639.867202655823, 4641.327007583949, 4731.924249238023, 4853.781579828987, 4891.779869905791, 4897.2654101885, 4680.274557443602, 4814.109389762905, 4823.879403014953, 4848.175810112219, 4935.777889995031], "value": 4158.204045486405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.89126968656444, 300.7338505422701, 302.81679583851775, 307.9168624471391, 308.92585779412934, 4870.4398994115645, 4879.804807807684, 4893.41279046515, 4900.166971614825, 4925.138100832353, 4823.8794030149265, 4835.830745923893, 4850.34520339754, 4853.830115945942, 4863.975680121604, 3622.7826330420194, 3724.29238444696, 3743.794091324976, 3834.118152824852, 3852.669135173222, 3772.792496412696, 3838.558565764945, 3838.5777564467885, 3857.4213867919757, 3864.401017842225, 3814.8255494368223, 3814.866479673212, 3828.406596977473, 3839.577646458887, 3852.152526444178, 3651.9817400912957, 3735.9452301234346, 3821.5605205401457, 3831.4444405561317, 3843.9231215375817, 3392.4063288924585, 3393.5588373511287, 3398.065531978701, 3398.3203359327986, 3414.4536874100027, 4779.872956534344, 4783.760811959388, 4787.257975013878, 4793.9280910786365, 4796.400449943757, 4248.171606536726, 4393.6045755881805, 4400.823967041314, 4402.889927751832, 4409.691321607489, 5013.423456302536, 5058.949410505885, 5062.0, 5096.1846104623455, 5116.362763915548, 3718.200586873808, 3721.962780372216, 3730.1047748540427, 3736.7757934524016, 3743.026813028632, 5080.0, 5298.072837253504, 5317.580500872133, 5366.195070739382, 5366.838994830161, 3793.374093274634, 3808.9238215236096, 3809.104860357814, 3814.6376094271, 3816.4084566892175, 3791.469194312798, 3815.523059617548, 3819.3316169670197, 3831.750936189139, 3833.5783063862955, 4323.156984388014, 4337.501187363494, 4351.586599273064, 4358.411614432074, 4371.322445021026, 4819.783109760069, 5107.87230319245, 5120.308758317579, 5121.8719532012, 5141.511556402136, 1286.7297867447753, 1293.4502836294726, 1294.501616877509, 1298.623399214236, 1299.2594221293962, 813.7477382011477, 813.983720325602, 815.3477218225396, 862.7498025572639, 882.6601758323092, 4421.712588681726, 4422.049259409178, 4431.556844315607, 4433.492612511697, 4479.0, 5190.6107041971245, 5190.974045129826, 5213.191955246943, 5249.527542521115, 5251.426800867547, 4246.789664945476, 4369.126174764996, 4405.669574781904, 4405.757683327448, 4419.646428285794, 2744.245332533529, 2761.4477104579164, 2779.277387879166, 2832.5412412607525, 2837.7230246388795, 4934.519644106826, 4977.776000079933, 4982.526659967298, 5021.874453138627, 5023.271625614266, 5302.549283310885, 5326.6537675050995, 5434.64674796137, 5458.4814442627885, 5474.151506516497, 4994.275830004629, 4997.650634328711, 5009.497150854656, 5018.899622007612, 5021.84934451967, 5243.528082472596, 5246.422893481637, 5276.34045744282, 5309.734513274244, 5322.9467705324, 4909.26361045846, 5186.507281808223, 5190.0, 5195.584353251656, 5213.374395072616, 4972.950270497248, 4986.825461108844, 4986.975065124796, 5000.724960127082, 5003.949960500494, 3698.7595806272507, 3700.944485832661, 3706.1105334720014, 3711.498947642142, 3717.8698745544857, 5153.093355458504, 5318.920216196838, 5333.200019997032, 5338.679679219259, 5366.2487251784005, 5133.460986596503, 5149.639525233198, 5150.562202212854, 5151.278820965143, 5162.793488260578, 5105.744712764421, 5112.693238405707, 5119.436861945109, 5125.897482050413, 5147.176451767699, 4932.4081110267, 5072.137736584716, 5074.467180946095, 5093.974530127326, 5093.974530127474, 4944.975275123601, 5033.169527028, 5168.457311982338, 5178.922316165336, 5185.896282074413, 5031.798728050983, 5038.370203724535, 5040.974795126148, 5042.865355295029, 5047.419546752024], "value": 3858.4737887103297, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.0802887639662, 609.7530500147441, 642.0882347067164, 699.3845416033889, 735.9043324367832, 12998.41507132179, 13900.652483687913, 13942.302884855755, 13951.232682202475, 13972.720545589094, 13007.219566825974, 13780.724385512309, 14270.928645356784, 14301.070430422014, 14844.55466336009, 779.7231982646164, 795.5028107432854, 798.9400794940402, 799.1050023973129, 800.4076983032572, 625.4058644287921, 759.6050053971959, 788.207851109634, 791.639803889229, 792.0851416613821, 832.2052439919893, 836.021854430315, 836.6862426590029, 836.7991681996308, 837.2381133168817, 645.5577929118568, 825.4593241426875, 825.8719898415756, 825.9463134896213, 826.5784449930549, 583.4894467341077, 602.6956387024525, 603.414687752879, 603.4177019176472, 603.809799913026, 12717.809232861515, 12773.361331933365, 12780.808287875689, 12796.0, 12860.935695321557, 12332.198407103599, 12944.352782360938, 13047.54333598329, 13052.347382630925, 13115.737685246337, 11825.172237943347, 12009.519619215222, 12070.27578345302, 12134.817977730341, 12513.874861251363, 4089.488813898263, 4148.979255103705, 4194.0, 4201.369794530814, 4312.460942382202, 45037.324440133096, 45577.088458230646, 45612.543874560826, 45824.312635310496, 45958.77020614909, 9886.802263954825, 9895.208383329316, 10226.846597301046, 10372.0, 10657.147428205724, 17812.287508499514, 18360.908195459204, 18373.0, 19168.71246931297, 19201.423957281302, 6877.89683154753, 6959.851624482005, 6965.0, 6991.825204369829, 7070.611116388545, 3239.4330992076293, 3333.4333163362285, 3388.4917262410345, 3523.1016090896655, 3541.2386336937166, 2848.7293707097792, 2997.505411607104, 2997.775166862494, 3000.8949686760857, 3003.294225856922, 466.477545149428, 470.927391289329, 476.2522839142513, 480.0926249388658, 486.8077109541711, 406.2362758014972, 426.49460389438616, 437.0494175168995, 482.14178761804044, 497.9078870408986, 6783.728650854009, 6997.148171109733, 7075.92924070763, 7126.928730712731, 7325.963370183222, 422.7167797575632, 424.0987900710989, 493.77286448233497, 497.7536119620811, 504.5559907281642, 3526.7354948378975, 3554.644535546425, 3623.221007483351, 3648.689861361761, 3712.2389910068373, 50890.49109508932, 51291.23063154056, 51457.742711286206, 51493.227601586004, 79378.20621793708, 74867.62566187134, 77415.61292193503, 79283.60358198172, 79422.20577794264, 84032.0, 54492.45507544953, 66658.00077993004, 68394.65802670954, 69064.6546767273, 70542.0, 7047.982362704014, 7068.858622827617, 7115.217326094022, 7134.821629459305, 7157.85684286301, 41126.0, 42009.0, 42348.0, 42766.8215470508, 43216.35175472307, 51468.74265628648, 61111.69444152751, 62555.0, 62981.370186299384, 63116.0, 9093.54532273397, 9195.126462986005, 9200.0, 9221.49281789508, 9546.093121153479, 10102.0, 10381.273310868166, 10579.841302380624, 10766.46167691628, 10955.452227388758, 8239.823489274393, 9497.335186536877, 9949.353292035994, 10997.829833090595, 11692.824607630722, 10278.229132814919, 10422.947885260524, 10486.632967846088, 10494.47527623631, 11011.669649910515, 11321.264117832314, 11509.366984815915, 11516.769664606829, 11850.525978960744, 12005.459754311252, 8677.826443471222, 8718.607662655322, 8755.392235181318, 8874.600642970952, 9165.450072995642, 9007.549622518978, 9459.952700236454, 9653.0, 9657.979568896923, 9764.462954537568], "value": 6124.654806024853, "unit": "score"}], "name": "dromaeo_css", "value": 6222.187454978338, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 123.0, 192.0, 125.0, 128.0, 143.0, 122.0, 158.0, 127.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 163.0, 160.0, 162.0, 163.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 119.0, 78.0, 77.0, 76.0, 74.0, 112.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 124.0, 85.0, 85.0, 85.0, 114.0, 85.0, 84.0, 125.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 78.0, 78.0, 78.0, 79.0, 78.0, 80.0, 78.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 128.0, 127.0, 129.0, 140.0, 135.0, 129.0, 146.0, 170.0, 129.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 163.0, 174.0, 163.0, 166.0, 164.0, 166.0, 165.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1531.0, "alertThreshold": 2.0}]} 11:04:44 INFO - Return code: 0 11:04:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:04:44 INFO - # TBPL SUCCESS # 11:04:44 INFO - Running post-action listener: _resource_record_post_action 11:04:44 INFO - ##### 11:04:44 INFO - ##### Finished run-tests step (success) 11:04:44 INFO - ##### 11:04:44 INFO - Running post-run listener: _resource_record_post_run 11:04:44 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 542498816; Read time: 0; Write time: 411808 11:04:44 INFO - TinderboxPrint: CPU usage
13.0% 11:04:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:04:44 INFO - TinderboxPrint: I/O write bytes / time
542,498,816 / 411,808 11:04:44 INFO - TinderboxPrint: CPU idle
8,336.6 (87.0%) 11:04:44 INFO - TinderboxPrint: CPU user
1,198.9 (12.5%) 11:04:44 INFO - TinderboxPrint: Swap in / out
0 / 0 11:04:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253734912; Read time: 0; Write time: 241740 11:04:44 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288145408; Read time: 0; Write time: 170068 11:04:45 INFO - Running post-run listener: _upload_blobber_files 11:04:45 INFO - Blob upload gear active. 11:04:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:04:45 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 11:04:45 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'] 11:04:45 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 11:04:45 INFO - (blobuploader) - INFO - Open directory for files ... 11:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:46 INFO - (blobuploader) - INFO - Done attempting. 11:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:50 INFO - (blobuploader) - INFO - Done attempting. 11:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:04:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:51 INFO - (blobuploader) - INFO - Done attempting. 11:04:51 INFO - (blobuploader) - INFO - Iteration through files over. 11:04:51 INFO - Return code: 0 11:04:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:04:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:04:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/850c5e3cec45761ce0708ffb309b753be6fb2b77c7e2b3181f51c38b8885baa56bf6b67e078fea9c6b2b76625d1a7b86f558d3c10128a8147efe4140d4f65240", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c284071a0a4c54261c5cb94b3eb62a5c6e654e4f97599a3a100e17e8a7768cb287ff9ee8e4d0d9291fd32c2cdca386bb80848a35ad5c80c7cd71ff8f166d653b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4bcca456786540238fcbe792b88672426781fcbea293f7c1e45a60e33afda895b7bbe66ea6071e12c0c9f9f1d4791163900914ecdc5ed6f52008b6b8f7be41"} 11:04:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:04:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:04:51 INFO - Contents: 11:04:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/850c5e3cec45761ce0708ffb309b753be6fb2b77c7e2b3181f51c38b8885baa56bf6b67e078fea9c6b2b76625d1a7b86f558d3c10128a8147efe4140d4f65240", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c284071a0a4c54261c5cb94b3eb62a5c6e654e4f97599a3a100e17e8a7768cb287ff9ee8e4d0d9291fd32c2cdca386bb80848a35ad5c80c7cd71ff8f166d653b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4bcca456786540238fcbe792b88672426781fcbea293f7c1e45a60e33afda895b7bbe66ea6071e12c0c9f9f1d4791163900914ecdc5ed6f52008b6b8f7be41"} 11:04:51 INFO - Running post-run listener: copy_logs_to_upload_dir 11:04:51 INFO - Copying logs to upload dir... 11:04:51 INFO - mkdir: /builds/slave/test/build/upload/logs 11:04:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.098687 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-13 11:04:50.630758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 11:04:50.634479) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725 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/850c5e3cec45761ce0708ffb309b753be6fb2b77c7e2b3181f51c38b8885baa56bf6b67e078fea9c6b2b76625d1a7b86f558d3c10128a8147efe4140d4f65240", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c284071a0a4c54261c5cb94b3eb62a5c6e654e4f97599a3a100e17e8a7768cb287ff9ee8e4d0d9291fd32c2cdca386bb80848a35ad5c80c7cd71ff8f166d653b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4bcca456786540238fcbe792b88672426781fcbea293f7c1e45a60e33afda895b7bbe66ea6071e12c0c9f9f1d4791163900914ecdc5ed6f52008b6b8f7be41"} build_url:https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/bs3N6dB-S6q_s2HDK-YdPQ/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/850c5e3cec45761ce0708ffb309b753be6fb2b77c7e2b3181f51c38b8885baa56bf6b67e078fea9c6b2b76625d1a7b86f558d3c10128a8147efe4140d4f65240", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c284071a0a4c54261c5cb94b3eb62a5c6e654e4f97599a3a100e17e8a7768cb287ff9ee8e4d0d9291fd32c2cdca386bb80848a35ad5c80c7cd71ff8f166d653b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4bcca456786540238fcbe792b88672426781fcbea293f7c1e45a60e33afda895b7bbe66ea6071e12c0c9f9f1d4791163900914ecdc5ed6f52008b6b8f7be41"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 11:04:50.659522) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:04:50.659836) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468431845.555502-23051725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:04:50.741860) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 11:04:50.742208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 11:04:50.742524) ========= ========= Total master_lag: 0.17 =========