builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1467957634.52 results: success (0) buildid: 20160707203023 builduid: 579889a6bf8e4c319edfdbba30cacf10 revision: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.516084) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.516554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.516897) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.535549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.535886) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 23:00:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 94.3M=0s 2016-07-07 23:00:34 (94.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133116 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.683611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.684052) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018504 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:34.734088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 23:00:34.734412) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 74dd49dcf6c944a1de2b1762ee328710aa4358a4 --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 74dd49dcf6c944a1de2b1762ee328710aa4358a4 --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=652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 23:00:35,057 truncating revision to first 12 chars 2016-07-07 23:00:35,057 Setting DEBUG logging. 2016-07-07 23:00:35,057 attempt 1/10 2016-07-07 23:00:35,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/74dd49dcf6c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 23:00:36,364 unpacking tar archive at: fx-team-74dd49dcf6c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.634452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 23:00:36.383084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:36.383402) ========= script_repo_revision: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:36.383861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:36.384159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 23:00:36.393528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-07 23:00:36.393844) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:00:36 INFO - MultiFileLogger online at 20160707 23:00:36 in /builds/slave/test 23:00:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:00:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:00:36 INFO - {'append_to_log': False, 23:00:36 INFO - 'base_work_dir': '/builds/slave/test', 23:00:36 INFO - 'blob_upload_branch': 'Fx-Team', 23:00:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:00:36 INFO - 'branch': 'Fx-Team', 23:00:36 INFO - 'buildbot_json_path': 'buildprops.json', 23:00:36 INFO - 'config_files': ('talos/linux_config.py',), 23:00:36 INFO - 'default_actions': ('clobber', 23:00:36 INFO - 'read-buildbot-config', 23:00:36 INFO - 'download-and-extract', 23:00:36 INFO - 'populate-webroot', 23:00:36 INFO - 'create-virtualenv', 23:00:36 INFO - 'install', 23:00:36 INFO - 'run-tests'), 23:00:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:00:36 INFO - 'download_minidump_stackwalk': True, 23:00:36 INFO - 'download_symbols': 'ondemand', 23:00:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:00:36 INFO - 'tooltool.py': '/tools/tooltool.py', 23:00:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:00:36 INFO - '/tools/misc-python/virtualenv.py')}, 23:00:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:00:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:00:36 INFO - 'installer_path': 'installer.exe', 23:00:36 INFO - 'log_level': 'info', 23:00:36 INFO - 'log_name': 'talos', 23:00:36 INFO - 'log_to_console': True, 23:00:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:00:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:00:36 INFO - 'opt_config_files': (), 23:00:36 INFO - 'pip_index': False, 23:00:36 INFO - 'sps_profile': False, 23:00:36 INFO - 'sps_profile_interval': 0, 23:00:36 INFO - 'suite': 'dromaeojs', 23:00:36 INFO - 'system_bits': '32', 23:00:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:00:36 INFO - 'title': 'talos-linux64-ix-046', 23:00:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:00:36 INFO - 'use_talos_json': True, 23:00:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:00:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:00:36 INFO - 'work_dir': 'build'} 23:00:36 INFO - ##### 23:00:36 INFO - ##### Running clobber step. 23:00:36 INFO - ##### 23:00:36 INFO - Running pre-action listener: _resource_record_pre_action 23:00:36 INFO - Running main action method: clobber 23:00:36 INFO - rmtree: /builds/slave/test/build 23:00:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:00:37 INFO - Running post-action listener: _resource_record_post_action 23:00:37 INFO - ##### 23:00:37 INFO - ##### Finished clobber step (success) 23:00:37 INFO - ##### 23:00:37 INFO - ##### 23:00:37 INFO - ##### Running read-buildbot-config step. 23:00:37 INFO - ##### 23:00:37 INFO - Running pre-action listener: _resource_record_pre_action 23:00:37 INFO - Running main action method: read_buildbot_config 23:00:37 INFO - Using buildbot properties: 23:00:37 INFO - { 23:00:37 INFO - "project": "", 23:00:37 INFO - "product": "firefox", 23:00:37 INFO - "script_repo_revision": "production", 23:00:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:00:37 INFO - "repository": "", 23:00:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:00:37 INFO - "buildid": "20160707203023", 23:00:37 INFO - "pgo_build": "True", 23:00:37 INFO - "basedir": "/builds/slave/test", 23:00:37 INFO - "buildnumber": 1315, 23:00:37 INFO - "slavename": "talos-linux64-ix-046", 23:00:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:00:37 INFO - "platform": "ubuntu64_hw", 23:00:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:00:37 INFO - "branch": "fx-team", 23:00:37 INFO - "repo_path": "integration/fx-team", 23:00:37 INFO - "revision": "74dd49dcf6c944a1de2b1762ee328710aa4358a4", 23:00:37 INFO - "stage_platform": "linux64-pgo", 23:00:37 INFO - "builduid": "579889a6bf8e4c319edfdbba30cacf10", 23:00:37 INFO - "slavebuilddir": "test" 23:00:37 INFO - } 23:00:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:00:37 INFO - Running post-action listener: _resource_record_post_action 23:00:37 INFO - ##### 23:00:37 INFO - ##### Finished read-buildbot-config step (success) 23:00:37 INFO - ##### 23:00:37 INFO - ##### 23:00:37 INFO - ##### Running download-and-extract step. 23:00:37 INFO - ##### 23:00:37 INFO - Running pre-action listener: _resource_record_pre_action 23:00:37 INFO - Running main action method: download_and_extract 23:00:37 INFO - mkdir: /builds/slave/test/build/tests 23:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:37 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:38 INFO - Downloaded 1361 bytes. 23:00:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:00:38 INFO - Using the following test package requirements: 23:00:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:00:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:00:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'jsshell-linux-x86_64.zip'], 23:00:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:00:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:00:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:00:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:00:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:00:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:38 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:40 INFO - Downloaded 24304424 bytes. 23:00:40 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'] 23:00:40 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 23:00:41 INFO - Return code: 0 23:00:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:41 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:48 INFO - Downloaded 24304424 bytes. 23:00:48 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'] 23:00:48 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 23:00:49 INFO - Return code: 0 23:00:49 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')]} 23:00:49 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:50 INFO - Downloaded 14403333 bytes. 23:00:50 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'] 23:00:50 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 23:00:51 INFO - Return code: 0 23:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:51 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:00:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:00:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:00:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:00:52 INFO - Downloaded 60445099 bytes. 23:00:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:00:52 INFO - mkdir: /builds/slave/test/properties 23:00:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:00:52 INFO - Writing to file /builds/slave/test/properties/build_url 23:00:52 INFO - Contents: 23:00:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:00:53 INFO - Running post-action listener: _resource_record_post_action 23:00:53 INFO - Running post-action listener: set_extra_try_arguments 23:00:53 INFO - ##### 23:00:53 INFO - ##### Finished download-and-extract step (success) 23:00:53 INFO - ##### 23:00:53 INFO - ##### 23:00:53 INFO - ##### Running populate-webroot step. 23:00:53 INFO - ##### 23:00:53 INFO - Running pre-action listener: _resource_record_pre_action 23:00:53 INFO - Running main action method: populate_webroot 23:00:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:00:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:00:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:00:53 INFO - '--tppagecycles', 23:00:53 INFO - '7'], 23:00:53 INFO - 'tests': ['tsvgm']}}, 23:00:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:00:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:00:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:00:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:00:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['damp', 'tps']}, 23:00:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'tests': ['damp', 'tps']}, 23:00:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['dromaeo_dom']}, 23:00:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:00:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['basic_compositor_video']}, 23:00:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:00:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['a11yr', 23:00:53 INFO - 'ts_paint', 23:00:53 INFO - 'tpaint', 23:00:53 INFO - 'sessionrestore', 23:00:53 INFO - 'sessionrestore_no_auto_restore', 23:00:53 INFO - 'tabpaint']}, 23:00:53 INFO - 'other-e10s': {'tests': ['a11yr', 23:00:53 INFO - 'ts_paint', 23:00:53 INFO - 'tpaint', 23:00:53 INFO - 'sessionrestore', 23:00:53 INFO - 'sessionrestore_no_auto_restore', 23:00:53 INFO - 'tabpaint']}, 23:00:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:00:53 INFO - 'ts_paint', 23:00:53 INFO - 'tpaint', 23:00:53 INFO - 'sessionrestore', 23:00:53 INFO - 'sessionrestore_no_auto_restore', 23:00:53 INFO - 'tabpaint']}, 23:00:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:00:53 INFO - 'ts_paint', 23:00:53 INFO - 'tpaint', 23:00:53 INFO - 'sessionrestore', 23:00:53 INFO - 'sessionrestore_no_auto_restore', 23:00:53 INFO - 'tabpaint']}, 23:00:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['a11yr', 23:00:53 INFO - 'ts_paint', 23:00:53 INFO - 'tpaint', 23:00:53 INFO - 'sessionrestore', 23:00:53 INFO - 'sessionrestore_no_auto_restore', 23:00:53 INFO - 'tabpaint']}, 23:00:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['a11yr', 23:00:53 INFO - 'ts_paint', 23:00:53 INFO - 'tpaint', 23:00:53 INFO - 'sessionrestore', 23:00:53 INFO - 'sessionrestore_no_auto_restore', 23:00:53 INFO - 'tabpaint']}, 23:00:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['tsvgx', 23:00:53 INFO - 'tsvgr_opacity', 23:00:53 INFO - 'tart', 23:00:53 INFO - 'tscrollx', 23:00:53 INFO - 'cart']}, 23:00:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:00:53 INFO - 'tsvgr_opacity', 23:00:53 INFO - 'tart', 23:00:53 INFO - 'tscrollx', 23:00:53 INFO - 'cart']}, 23:00:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'talos_options': ['--disable-e10s'], 23:00:53 INFO - 'tests': ['tp5o']}, 23:00:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'tests': ['tp5o']}, 23:00:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'talos_options': ['--disable-e10s', 23:00:53 INFO - '--xperf_path', 23:00:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:53 INFO - 'tests': ['tp5n']}, 23:00:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:53 INFO - 'talos_options': ['--xperf_path', 23:00:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:53 INFO - 'tests': ['tp5n']}}, 23:00:53 INFO - 'talos.zip': {'path': '', 23:00:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:00:53 INFO - Running post-action listener: _resource_record_post_action 23:00:53 INFO - ##### 23:00:53 INFO - ##### Finished populate-webroot step (success) 23:00:53 INFO - ##### 23:00:53 INFO - ##### 23:00:53 INFO - ##### Running create-virtualenv step. 23:00:53 INFO - ##### 23:00:53 INFO - Running pre-action listener: _resource_record_pre_action 23:00:53 INFO - Running main action method: create_virtualenv 23:00:53 INFO - Creating virtualenv /builds/slave/test/build/venv 23:00:53 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 23:00:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:00:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:00:53 INFO - Using real prefix '/usr' 23:00:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:00:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:00:55 INFO - Installing pip.................done. 23:00:55 INFO - Return code: 0 23:00:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:00:55 INFO - Using env: {'DISPLAY': ':0', 23:00:55 INFO - 'HOME': '/home/cltbld', 23:00:55 INFO - 'LANG': 'en_US.UTF-8', 23:00:55 INFO - 'LANGUAGE': 'en_US:en', 23:00:55 INFO - 'LOGNAME': 'cltbld', 23:00:55 INFO - 'MAIL': '/var/mail/cltbld', 23:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:55 INFO - 'MOZ_NO_REMOTE': '1', 23:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:55 INFO - 'NO_EM_RESTART': '1', 23:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:55 INFO - 'PWD': '/builds/slave/test', 23:00:55 INFO - 'SHELL': '/bin/bash', 23:00:55 INFO - 'SHLVL': '1', 23:00:55 INFO - 'TERM': 'linux', 23:00:55 INFO - 'TMOUT': '86400', 23:00:55 INFO - 'USER': 'cltbld', 23:00:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:55 INFO - '_': '/tools/buildbot/bin/python'} 23:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:56 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 23:00:56 INFO - Cleaning up... 23:00:56 INFO - Return code: 0 23:00:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:56 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:00:56 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 23:00:56 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 23:00:56 INFO - Using env: {'DISPLAY': ':0', 23:00:56 INFO - 'HOME': '/home/cltbld', 23:00:56 INFO - 'LANG': 'en_US.UTF-8', 23:00:56 INFO - 'LANGUAGE': 'en_US:en', 23:00:56 INFO - 'LOGNAME': 'cltbld', 23:00:56 INFO - 'MAIL': '/var/mail/cltbld', 23:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:56 INFO - 'MOZ_NO_REMOTE': '1', 23:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:56 INFO - 'NO_EM_RESTART': '1', 23:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:56 INFO - 'PWD': '/builds/slave/test', 23:00:56 INFO - 'SHELL': '/bin/bash', 23:00:56 INFO - 'SHLVL': '1', 23:00:56 INFO - 'TERM': 'linux', 23:00:56 INFO - 'TMOUT': '86400', 23:00:56 INFO - 'USER': 'cltbld', 23:00:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:56 INFO - '_': '/tools/buildbot/bin/python'} 23:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:56 INFO - Downloading/unpacking psutil>=3.1.1 23:00:56 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 23:00:56 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 23:00:56 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 23:00:56 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 23:00:56 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 23:00:56 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 23:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:00:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:58 INFO - Installing collected packages: psutil 23:00:58 INFO - Running setup.py install for psutil 23:00:58 INFO - building 'psutil._psutil_linux' extension 23:00:58 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 23:00:58 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 23:00:58 INFO - building 'psutil._psutil_posix' extension 23:00:58 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 23:00:58 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 23:00:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:58 INFO - Successfully installed psutil 23:00:58 INFO - Cleaning up... 23:00:58 INFO - Return code: 0 23:00:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:00:58 INFO - Using env: {'DISPLAY': ':0', 23:00:58 INFO - 'HOME': '/home/cltbld', 23:00:58 INFO - 'LANG': 'en_US.UTF-8', 23:00:58 INFO - 'LANGUAGE': 'en_US:en', 23:00:58 INFO - 'LOGNAME': 'cltbld', 23:00:58 INFO - 'MAIL': '/var/mail/cltbld', 23:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:58 INFO - 'MOZ_NO_REMOTE': '1', 23:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:58 INFO - 'NO_EM_RESTART': '1', 23:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:58 INFO - 'PWD': '/builds/slave/test', 23:00:58 INFO - 'SHELL': '/bin/bash', 23:00:58 INFO - 'SHLVL': '1', 23:00:58 INFO - 'TERM': 'linux', 23:00:58 INFO - 'TMOUT': '86400', 23:00:58 INFO - 'USER': 'cltbld', 23:00:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:58 INFO - '_': '/tools/buildbot/bin/python'} 23:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:00:59 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 23:00:59 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 23:00:59 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 23:00:59 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 23:00:59 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 23:00:59 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 23:01:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:01:01 INFO - Installing collected packages: mozsystemmonitor 23:01:01 INFO - Running setup.py install for mozsystemmonitor 23:01:01 INFO - Successfully installed mozsystemmonitor 23:01:01 INFO - Cleaning up... 23:01:01 INFO - Return code: 0 23:01:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:01 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:01:01 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 23:01:01 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 23:01:01 INFO - Using env: {'DISPLAY': ':0', 23:01:01 INFO - 'HOME': '/home/cltbld', 23:01:01 INFO - 'LANG': 'en_US.UTF-8', 23:01:01 INFO - 'LANGUAGE': 'en_US:en', 23:01:01 INFO - 'LOGNAME': 'cltbld', 23:01:01 INFO - 'MAIL': '/var/mail/cltbld', 23:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:01 INFO - 'MOZ_NO_REMOTE': '1', 23:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:01 INFO - 'NO_EM_RESTART': '1', 23:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:01 INFO - 'PWD': '/builds/slave/test', 23:01:01 INFO - 'SHELL': '/bin/bash', 23:01:01 INFO - 'SHLVL': '1', 23:01:01 INFO - 'TERM': 'linux', 23:01:01 INFO - 'TMOUT': '86400', 23:01:01 INFO - 'USER': 'cltbld', 23:01:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:01 INFO - '_': '/tools/buildbot/bin/python'} 23:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:01 INFO - Downloading/unpacking jsonschema==2.5.1 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:01:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:03 INFO - Downloading functools32-3.2.3-2.tar.gz 23:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:01:03 INFO - warning: no files found matching '*.txt' 23:01:03 INFO - no previously-included directories found matching 'build' 23:01:03 INFO - no previously-included directories found matching 'dist' 23:01:03 INFO - no previously-included directories found matching '.git*' 23:01:03 INFO - Installing collected packages: jsonschema, functools32 23:01:03 INFO - Running setup.py install for functools32 23:01:03 INFO - warning: no files found matching '*.txt' 23:01:03 INFO - no previously-included directories found matching 'build' 23:01:03 INFO - no previously-included directories found matching 'dist' 23:01:03 INFO - no previously-included directories found matching '.git*' 23:01:03 INFO - Successfully installed jsonschema functools32 23:01:03 INFO - Cleaning up... 23:01:03 INFO - Return code: 0 23:01:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:01:03 INFO - Using env: {'DISPLAY': ':0', 23:01:03 INFO - 'HOME': '/home/cltbld', 23:01:03 INFO - 'LANG': 'en_US.UTF-8', 23:01:03 INFO - 'LANGUAGE': 'en_US:en', 23:01:03 INFO - 'LOGNAME': 'cltbld', 23:01:03 INFO - 'MAIL': '/var/mail/cltbld', 23:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:03 INFO - 'MOZ_NO_REMOTE': '1', 23:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:03 INFO - 'NO_EM_RESTART': '1', 23:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:03 INFO - 'PWD': '/builds/slave/test', 23:01:03 INFO - 'SHELL': '/bin/bash', 23:01:03 INFO - 'SHLVL': '1', 23:01:03 INFO - 'TERM': 'linux', 23:01:03 INFO - 'TMOUT': '86400', 23:01:03 INFO - 'USER': 'cltbld', 23:01:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:03 INFO - '_': '/tools/buildbot/bin/python'} 23:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:04 INFO - Downloading/unpacking blobuploader==1.2.4 23:01:04 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 23:01:04 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 23:01:04 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 23:01:04 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 23:01:04 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 23:01:04 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 23:01:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:01:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:01:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:06 INFO - Downloading docopt-0.6.1.tar.gz 23:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:01:06 INFO - Installing collected packages: blobuploader, requests, docopt 23:01:06 INFO - Running setup.py install for blobuploader 23:01:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:01:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:01:06 INFO - Running setup.py install for requests 23:01:07 INFO - Running setup.py install for docopt 23:01:07 INFO - Successfully installed blobuploader requests docopt 23:01:07 INFO - Cleaning up... 23:01:07 INFO - Return code: 0 23:01:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:07 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:01:07 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 23:01:07 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 23:01:07 INFO - Using env: {'DISPLAY': ':0', 23:01:07 INFO - 'HOME': '/home/cltbld', 23:01:07 INFO - 'LANG': 'en_US.UTF-8', 23:01:07 INFO - 'LANGUAGE': 'en_US:en', 23:01:07 INFO - 'LOGNAME': 'cltbld', 23:01:07 INFO - 'MAIL': '/var/mail/cltbld', 23:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:07 INFO - 'MOZ_NO_REMOTE': '1', 23:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:07 INFO - 'NO_EM_RESTART': '1', 23:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:07 INFO - 'PWD': '/builds/slave/test', 23:01:07 INFO - 'SHELL': '/bin/bash', 23:01:07 INFO - 'SHLVL': '1', 23:01:07 INFO - 'TERM': 'linux', 23:01:07 INFO - 'TMOUT': '86400', 23:01:07 INFO - 'USER': 'cltbld', 23:01:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:07 INFO - '_': '/tools/buildbot/bin/python'} 23:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:07 INFO - Running setup.py (path:/tmp/pip-nxzI7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:07 INFO - Running setup.py (path:/tmp/pip-Smyicv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:07 INFO - Running setup.py (path:/tmp/pip-H3IHyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:07 INFO - Running setup.py (path:/tmp/pip-DvFsdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:07 INFO - Running setup.py (path:/tmp/pip-SD6WEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:07 INFO - Running setup.py (path:/tmp/pip-IO4RT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:07 INFO - Running setup.py (path:/tmp/pip-DZQqXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:08 INFO - Running setup.py (path:/tmp/pip-dFlY36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:08 INFO - Running setup.py (path:/tmp/pip-wxmWd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:08 INFO - Running setup.py (path:/tmp/pip-zYSm3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:08 INFO - Running setup.py (path:/tmp/pip-ciGhXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:08 INFO - Running setup.py (path:/tmp/pip-AxHwvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:08 INFO - Running setup.py (path:/tmp/pip-_EOyIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:08 INFO - Running setup.py (path:/tmp/pip-EbOUyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:08 INFO - Running setup.py (path:/tmp/pip-j6FI32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:08 INFO - Running setup.py (path:/tmp/pip-poufmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:08 INFO - Running setup.py (path:/tmp/pip-ECdGHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:01:08 INFO - Running setup.py install for manifestparser 23:01:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:01:08 INFO - Running setup.py install for mozcrash 23:01:08 INFO - Running setup.py install for mozdebug 23:01:08 INFO - Running setup.py install for mozdevice 23:01:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Running setup.py install for mozfile 23:01:09 INFO - Running setup.py install for mozhttpd 23:01:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Running setup.py install for mozinfo 23:01:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Running setup.py install for mozInstall 23:01:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Running setup.py install for mozleak 23:01:09 INFO - Running setup.py install for mozlog 23:01:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Running setup.py install for moznetwork 23:01:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:01:09 INFO - Running setup.py install for mozprocess 23:01:09 INFO - Running setup.py install for mozprofile 23:01:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Running setup.py install for mozrunner 23:01:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Running setup.py install for mozscreenshot 23:01:10 INFO - Running setup.py install for moztest 23:01:10 INFO - Running setup.py install for mozversion 23:01:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:01:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:01:10 INFO - Cleaning up... 23:01:10 INFO - Return code: 0 23:01:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:10 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:01:10 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 23:01:10 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 23:01:10 INFO - Using env: {'DISPLAY': ':0', 23:01:10 INFO - 'HOME': '/home/cltbld', 23:01:10 INFO - 'LANG': 'en_US.UTF-8', 23:01:10 INFO - 'LANGUAGE': 'en_US:en', 23:01:10 INFO - 'LOGNAME': 'cltbld', 23:01:10 INFO - 'MAIL': '/var/mail/cltbld', 23:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:10 INFO - 'MOZ_NO_REMOTE': '1', 23:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:10 INFO - 'NO_EM_RESTART': '1', 23:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:10 INFO - 'PWD': '/builds/slave/test', 23:01:10 INFO - 'SHELL': '/bin/bash', 23:01:10 INFO - 'SHLVL': '1', 23:01:10 INFO - 'TERM': 'linux', 23:01:10 INFO - 'TMOUT': '86400', 23:01:10 INFO - 'USER': 'cltbld', 23:01:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:10 INFO - '_': '/tools/buildbot/bin/python'} 23:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:10 INFO - Running setup.py (path:/tmp/pip-Idg1T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:10 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)) 23:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:10 INFO - Running setup.py (path:/tmp/pip-glwCLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:10 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)) 23:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:10 INFO - Running setup.py (path:/tmp/pip-McwE2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:10 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)) 23:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:10 INFO - Running setup.py (path:/tmp/pip-ZifaQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:11 INFO - Running setup.py (path:/tmp/pip-Mcbqsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:11 INFO - Running setup.py (path:/tmp/pip-vgRM5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:11 INFO - Running setup.py (path:/tmp/pip-p09Ru2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:11 INFO - Running setup.py (path:/tmp/pip-t4mQ8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:11 INFO - Running setup.py (path:/tmp/pip-D91Bs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:11 INFO - Running setup.py (path:/tmp/pip-UNJDks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:11 INFO - Running setup.py (path:/tmp/pip-ma1SXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:11 INFO - Running setup.py (path:/tmp/pip-mB8Iyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:11 INFO - Running setup.py (path:/tmp/pip-mbT6wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:11 INFO - Running setup.py (path:/tmp/pip-9IqzGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:11 INFO - Running setup.py (path:/tmp/pip-J9yQ0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:11 INFO - Running setup.py (path:/tmp/pip-3hcchp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:11 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)) 23:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:11 INFO - Running setup.py (path:/tmp/pip-cOgh30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:11 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)) 23:01:11 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)) 23:01:11 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)) 23:01:11 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)) 23:01:11 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)) 23:01:11 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)) 23:01:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:11 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 23:01:13 INFO - Downloading blessings-1.6.tar.gz 23:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:01:13 INFO - Installing collected packages: blessings 23:01:13 INFO - Running setup.py install for blessings 23:01:14 INFO - Successfully installed blessings 23:01:14 INFO - Cleaning up... 23:01:14 INFO - Return code: 0 23:01:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:14 INFO - Reading from file tmpfile_stdout 23:01:14 INFO - Current package versions: 23:01:14 INFO - argparse == 1.2.1 23:01:14 INFO - blessings == 1.6 23:01:14 INFO - blobuploader == 1.2.4 23:01:14 INFO - docopt == 0.6.1 23:01:14 INFO - functools32 == 3.2.3-2 23:01:14 INFO - jsonschema == 2.5.1 23:01:14 INFO - manifestparser == 1.1 23:01:14 INFO - mozInstall == 1.12 23:01:14 INFO - mozcrash == 0.17 23:01:14 INFO - mozdebug == 0.1 23:01:14 INFO - mozdevice == 0.48 23:01:14 INFO - mozfile == 1.2 23:01:14 INFO - mozhttpd == 0.7 23:01:14 INFO - mozinfo == 0.9 23:01:14 INFO - mozleak == 0.1 23:01:14 INFO - mozlog == 3.2 23:01:14 INFO - moznetwork == 0.27 23:01:14 INFO - mozprocess == 0.23 23:01:14 INFO - mozprofile == 0.28 23:01:14 INFO - mozrunner == 6.12 23:01:14 INFO - mozscreenshot == 0.1 23:01:14 INFO - mozsystemmonitor == 0.3 23:01:14 INFO - moztest == 0.7 23:01:14 INFO - mozversion == 1.4 23:01:14 INFO - psutil == 3.1.1 23:01:14 INFO - requests == 1.2.3 23:01:14 INFO - wsgiref == 0.1.2 23:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:14 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:01:14 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 23:01:14 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 23:01:14 INFO - Using env: {'DISPLAY': ':0', 23:01:14 INFO - 'HOME': '/home/cltbld', 23:01:14 INFO - 'LANG': 'en_US.UTF-8', 23:01:14 INFO - 'LANGUAGE': 'en_US:en', 23:01:14 INFO - 'LOGNAME': 'cltbld', 23:01:14 INFO - 'MAIL': '/var/mail/cltbld', 23:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:14 INFO - 'MOZ_NO_REMOTE': '1', 23:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:14 INFO - 'NO_EM_RESTART': '1', 23:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:14 INFO - 'PWD': '/builds/slave/test', 23:01:14 INFO - 'SHELL': '/bin/bash', 23:01:14 INFO - 'SHLVL': '1', 23:01:14 INFO - 'TERM': 'linux', 23:01:14 INFO - 'TMOUT': '86400', 23:01:14 INFO - 'USER': 'cltbld', 23:01:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:14 INFO - '_': '/tools/buildbot/bin/python'} 23:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 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)) 23:01:14 INFO - Cleaning up... 23:01:14 INFO - Return code: 0 23:01:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:14 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 0x16d5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, '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': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', '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 23:01:14 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 23:01:14 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 23:01:14 INFO - Using env: {'DISPLAY': ':0', 23:01:14 INFO - 'HOME': '/home/cltbld', 23:01:14 INFO - 'LANG': 'en_US.UTF-8', 23:01:14 INFO - 'LANGUAGE': 'en_US:en', 23:01:14 INFO - 'LOGNAME': 'cltbld', 23:01:14 INFO - 'MAIL': '/var/mail/cltbld', 23:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:14 INFO - 'MOZ_NO_REMOTE': '1', 23:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:14 INFO - 'NO_EM_RESTART': '1', 23:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:14 INFO - 'PWD': '/builds/slave/test', 23:01:14 INFO - 'SHELL': '/bin/bash', 23:01:14 INFO - 'SHLVL': '1', 23:01:14 INFO - 'TERM': 'linux', 23:01:14 INFO - 'TMOUT': '86400', 23:01:14 INFO - 'USER': 'cltbld', 23:01:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:14 INFO - '_': '/tools/buildbot/bin/python'} 23:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:01:14 INFO - Cleaning up... 23:01:14 INFO - Return code: 0 23:01:14 INFO - Running post-action listener: _resource_record_post_action 23:01:14 INFO - Running post-action listener: _start_resource_monitoring 23:01:14 INFO - Starting resource monitoring. 23:01:14 INFO - ##### 23:01:14 INFO - ##### Finished create-virtualenv step (success) 23:01:14 INFO - ##### 23:01:14 INFO - ##### 23:01:14 INFO - ##### Running install step. 23:01:14 INFO - ##### 23:01:14 INFO - Running pre-action listener: _resource_record_pre_action 23:01:14 INFO - Running main action method: install 23:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:14 INFO - Reading from file tmpfile_stdout 23:01:14 INFO - Detecting whether we're running mozinstall >=1.0... 23:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:01:15 INFO - Reading from file tmpfile_stdout 23:01:15 INFO - Output received: 23:01:15 INFO - Usage: mozinstall [options] installer 23:01:15 INFO - Options: 23:01:15 INFO - -h, --help show this help message and exit 23:01:15 INFO - -d DEST, --destination=DEST 23:01:15 INFO - Directory to install application into. [default: 23:01:15 INFO - "/builds/slave/test"] 23:01:15 INFO - --app=APP Application being installed. [default: firefox] 23:01:15 INFO - mkdir: /builds/slave/test/build/application 23:01:15 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'] 23:01:15 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 23:01:32 INFO - Reading from file tmpfile_stdout 23:01:32 INFO - Output received: 23:01:32 INFO - /builds/slave/test/build/application/firefox/firefox 23:01:32 INFO - Running post-action listener: _resource_record_post_action 23:01:32 INFO - ##### 23:01:32 INFO - ##### Finished install step (success) 23:01:32 INFO - ##### 23:01:32 INFO - ##### 23:01:32 INFO - ##### Running run-tests step. 23:01:32 INFO - ##### 23:01:32 INFO - Running pre-action listener: _resource_record_pre_action 23:01:32 INFO - Running main action method: run_tests 23:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:01:32 INFO - Python 2.7.3 23:01:32 INFO - Return code: 0 23:01:32 INFO - grabbing minidump binary from tooltool 23:01:32 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')]} 23:01:32 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 0x19943b0>, '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 0x19952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1995740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:01:32 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 23:01:32 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 23:01:32 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 23:01:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:01:32 INFO - Return code: 0 23:01:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:01:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:01:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:01:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:01:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 23:01:32 INFO - Using env: {'DISPLAY': ':0', 23:01:32 INFO - 'HOME': '/home/cltbld', 23:01:32 INFO - 'LANG': 'en_US.UTF-8', 23:01:32 INFO - 'LANGUAGE': 'en_US:en', 23:01:32 INFO - 'LOGNAME': 'cltbld', 23:01:32 INFO - 'MAIL': '/var/mail/cltbld', 23:01:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:01:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:32 INFO - 'MOZ_NO_REMOTE': '1', 23:01:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:32 INFO - 'NO_EM_RESTART': '1', 23:01:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:32 INFO - 'PWD': '/builds/slave/test', 23:01:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:01:32 INFO - 'SHELL': '/bin/bash', 23:01:32 INFO - 'SHLVL': '1', 23:01:32 INFO - 'TERM': 'linux', 23:01:32 INFO - 'TMOUT': '86400', 23:01:32 INFO - 'USER': 'cltbld', 23:01:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947', 23:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:32 INFO - '_': '/tools/buildbot/bin/python'} 23:01:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:01:32 INFO - mozversion application_buildid: 20160707203023 23:01:32 INFO - mozversion application_changeset: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 23:01:32 INFO - mozversion application_display_name: Nightly 23:01:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:01:32 INFO - mozversion application_name: Firefox 23:01:32 INFO - mozversion application_remotingname: firefox 23:01:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:01:32 INFO - mozversion application_vendor: Mozilla 23:01:32 INFO - mozversion application_version: 50.0a1 23:01:32 INFO - mozversion platform_buildid: 20160707203023 23:01:32 INFO - mozversion platform_changeset: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 23:01:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:01:32 INFO - mozversion platform_version: 50.0a1 23:01:32 INFO - using testdate: 1467957692 23:01:32 INFO - actual date: 1467957692 23:01:32 INFO - starting webserver on 'localhost:43823' 23:01:32 INFO - SUITE-START | Running 2 tests 23:01:32 INFO - TEST-START | dromaeo_css 23:01:32 INFO - operating with platform_type : linux_ 23:01:32 INFO - Initialising browser for dromaeo_css test... 23:01:32 INFO - TEST-INFO | started process 20897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsAeH2c/profile http://localhost:43823/getInfo.html) 23:01:36 INFO - PROCESS | 20897 | __metrics Screen width/height:1600/1200 23:01:36 INFO - PROCESS | 20897 | colorDepth:24 23:01:36 INFO - PROCESS | 20897 | Browser inner width/height: 1024/697 23:01:36 INFO - PROCESS | 20897 | __metrics 23:01:37 INFO - PROCESS | 20897 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:01:37 INFO - PROCESS | 20897 | console.error: PushService: 23:01:37 INFO - PROCESS | 20897 | stateChangeProcessEnqueue: Error transitioning state 23:01:37 INFO - PROCESS | 20897 | UnknownError 23:01:38 INFO - TEST-INFO | 20897: exit 0 23:01:38 INFO - Browser initialized. 23:01:38 INFO - Running cycle 1/1 for dromaeo_css test... 23:01:38 INFO - TEST-INFO | started process 20981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsAeH2c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:50 INFO - PROCESS | 20981 | RSS: Main: 156934144 23:01:50 INFO - PROCESS | 20981 | 23:02:41 INFO - PROCESS | 20981 | 1467957761477 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] 23:04:49 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:43823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43823/tests/dromaeo/cssquery-ext.html) 23:04:49 INFO - PROCESS | 20981 | RSS: Main: 246255616 23:04:49 INFO - PROCESS | 20981 | 23:07:52 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:43823/tests/dromaeo/cssquery-ext.html (next: http://localhost:43823/tests/dromaeo/cssquery-jquery.html) 23:07:53 INFO - PROCESS | 20981 | RSS: Main: 235864064 23:07:53 INFO - PROCESS | 20981 | 23:10:55 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:43823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43823/tests/dromaeo/cssquery-mootools.html) 23:10:55 INFO - PROCESS | 20981 | RSS: Main: 243458048 23:10:55 INFO - PROCESS | 20981 | 23:13:57 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:43823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43823/tests/dromaeo/cssquery-prototype.html) 23:13:58 INFO - PROCESS | 20981 | RSS: Main: 237547520 23:13:58 INFO - PROCESS | 20981 | 23:17:01 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:43823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43823/tests/dromaeo/cssquery-yui.html) 23:17:01 INFO - PROCESS | 20981 | RSS: Main: 224956416 23:17:01 INFO - PROCESS | 20981 | 23:20:04 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:43823/tests/dromaeo/cssquery-yui.html (next: http://localhost:43823/tests/dromaeo/cssquery-dojo.html) 23:20:05 INFO - PROCESS | 20981 | RSS: Main: 277975040 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | __start_tp_report 23:20:05 INFO - PROCESS | 20981 | _x_x_mozilla_page_load 23:20:05 INFO - PROCESS | 20981 | _x_x_mozilla_page_load_details 23:20:05 INFO - PROCESS | 20981 | |i|pagename|runs| 23:20:05 INFO - PROCESS | 20981 | |0;dojo.html;2990.2673844908;2991.820490770554;3018.6981301869814;3021.864016119274;3031.075521965801;5087.847364579068;5110.514501122397;5147.845564633062;5229.267902493649;5257.185136303879;5184.8703782405455;5187.377514698242;5198.896022079556;5222.007818514479;5259.211118332252;4671.20589499785;4736.834210802623;4761.999980004186;4766.642501812361;4913.041956818422;4809.110314591794;4837.129316722989;4877.146499362615;4892.9510704892855;4903.19097348937;4648.558386953251;4679.8362057328;4688.624910007208;4693.342931989524;4709.858704238878;4688.156131896258;4702.106599746037;4777.402824646919;4785.521447855222;4807.230843065127;4735.881602959919;4738.0523895221095;4765.809367625291;4779;4803.7357945313;5061.266116413136;5101.948980510185;5123.308353372285;5177.197534382177;5197.272381866542;5473.589480788917;5481.643693159932;5507.889842203133;5513.9448605514235;5523.696196709179;5398.433164517708;5546.722663866791;5566.777328906839;5571.164325351189;5574.080276754331;5134.229865520165;5181.559567436772;5186.636935414523;5201.24581935621;5211.9478805211465;5653.717314134359;5717.714114294268;5720.542356611461;5721.22763426932;5729.455701708331;5282;5308.495692909168;5421;5440.455954404528;5443.972780136074;5472.972635136799;5524.254225679562;5524.696141712164;5546.833594992157;5558.416366281563;5509.311336082989;5514.80698175562;5515.062439385234;5515.145152501369;5520.365158006881;5358.089124848785;5506.807261745819;5515.862103447365;5521.806736764194;5554.91667624986;4287.571242875688;4299.226139294957;4304.225239456928;4343.19650864591;4344.413504176959;3800.638939300762;3829.310724069694;3831.9042023949623;3872.2642697887313;3874.360730479439;5216.817411390659;5229.895402091937;5245.816396426107;5333.653312534673;5347.25138480613;5567.777288908398;5578.525825304894;5611;5614.185943038318;5669.574781891375;5304.655197412156;5310.734463276821;5318.9202161967605;5320.122179840283;5378.273933019071;4705.60002399793;4774;4806.399200099988;4835.153848076572;4850.611951043908;5786.392428795;5794.565407594448;5794.739236734273;5798.82603521895;5825.097109947965;5550.611457197957;5562.805301814417;5563.972180139235;5572.108462645957;5575.358833734173;5616.803411880564;5688;5717.828465146053;5744.971275143597;5795.449432303924;5467.699276539828;5475.589330800126;5480.451954804487;5481.945180548143;5482.095454250164;5537.031019571639;5560.527355174855;5579.525740312119;5587.106063029895;5631.915521267266;5306.230596563554;5306.681599104066;5323.3878104016985;5347.117725575236;5367.409584945731;5354.143337066051;5355.919661205163;5360.16917377807;5365.7048862311385;5367.919481207707;5254;5267.341582302212;5316.0696878046965;5320.680759154463;5356.758945847524;5349.7860085597695;5374;5422.9186562202385;5424.7558859850615;5511.5039646432015;5347.705876176692;5351.785928562969;5352.41123476425;5355.143177091647;5355.357357117171 23:20:05 INFO - PROCESS | 20981 | |1;ext.html;593.8812237552488;605.2313561776543;618.4866560754574;631.0597210156866;644.214058848205;32192.356152876928;42455.36316955248;43178;43225;43406.34890476641;44264.77867610657;44335;44597;44801;44863.77568112163;7987.680492780281;8857;8968.820623587524;8994.64021439145;10559.947200264027;10477.947610261937;10851.186161037915;10862.076723478514;10866.836997445045;10867.619633312836;10845.0781683557;10892.891071089307;10897.782044359108;10905.454727263645;10911.345319280868;8049.959750201241;8227.218414250636;10466.68599942003;10720.463976801208;10795.622153224638;10604.840927386096;10647.09499692527;10670.35977841332;10677.145828333714;10684.038436540748;41997.370039449124;42296;42569;42575.57424425747;42658.78670606627;2742.835429874214;3327.45097058985;3664.706823454117;3706.721995850295;3798.487204227449;30787.846060769552;32432.351352972808;32719.6728032719;33432.66567334344;34016.65983340184;4464.754438505881;4545.20458919691;4557.496026311309;4578.954210457886;4776.188048031843;353987;354365;354610.2269488662;355064;356367;60149.699251503465;60386.69806651027;60748.39251607516;60828.391716083155;60964;34456.31087378289;34983;35141.29717405637;37251.25497490035;62021;16893.155342233084;17051.658966820843;17135.22891469887;17139;17141.314347426214;12571.622851314476;12718.554850580185;12730.490780368867;12731.427085781163;12741.17182383142;19281.57911707923;19446;19503.829770213833;19558.381664454122;19591.60816783685;5940.405959404112;7071.469639777038;7285.526440781438;7330.853382932311;7331.230220826843;916.9037251088673;1095.6220104064084;1115.570505355444;1174.8061569841052;1193.9223950443193;31703;32719.672803271664;32869.67130328714;32892.3421531568;33381.499277510855;1082.9620963266248;1090.7654854206385;1115.5482029777952;1145.4616330324734;1179.510503141204;16876.24056917417;17351.30594776195;17354.566135846704;17363.56591085233;17425.39011134604;543462;547786;549125;550320;550440;56759.43240567624;58007.419925800205;58127.418725812204;58146.127808082914;58150.12774808381;1203.8615559210627;1296.8184454176424;1324.2782683437742;1344.4017412251649;1374.731927274192;30528.389432211676;33301;33327.166820829676;33583;33586.16034599154;48688.51311486981;49110.508894912025;49132;49238.75380623217;49247;381595;388382;390499;390961;391169;24141.034358626162;24592.631110533715;44577.331340029275;45546.31680524861;47024;46540;49436.258456122465;49629.044514658475;50093;50723.23915141202;41569.752907412825;42098;42632.14735705207;43442.131157377305;43546.564534355515;42496.02527823023;42568.5743142577;42883.7855810719;43667.344989824545;44101;41490.792546037075;42254.78872605618;42318.57681423146;42364.36453453262;42600.36099458449;36353;37336.43995340126;37838.62161378351;38229;38451;28598.57102143428;28823.85588072046;28909.421811563232;29117.417651647273;29125.7087429123 23:20:05 INFO - PROCESS | 20981 | |2;jquery.html;382.2469734622793;384.77682943892546;388.9630485103914;399.55649229355413;421.1282644925005;13290.986422986203;19366.225350985944;20076.397708068762;20082.89958550207;21039.789602103974;15763.605909852231;18009.459716208534;18701;18739.718904216414;19331.903340483277;5843.094320380348;6007.519398448136;6007.969960150193;6008.3390827009;6016.8495787605225;5792.189093526909;5906.527477801787;5910.911336329958;5945.078512830518;5955.672438015908;5755.280589926259;5796.971015144918;5826.883462330751;5886.352501224862;5888.7055647217685;5741.45456181662;5817.592768506206;5823.650580965134;5840.299164100293;5849.678267695275;5133.230015497668;5239.659422137549;5247.475252474722;5254;5261.421243663194;22973.77026229733;23206.65190022151;24189.637155442684;24217;24247.272581822574;2470.9752902470923;2535.911243106501;2628.8422694638384;2642.973570264292;2846.388026574276;14788.40846366144;14958.40166393343;15012.924935375253;15241.847581524155;15367.15480648564;1951.8926459044746;1962.1268535501708;1963.3324669612257;2039.9596205934931;2061.670132778763;79222.20777792206;80510;80664;81268.59365703193;82061.17938820596;9941.850872236922;10081.294309398418;10741.24811263204;10949.83575246372;10974.122070234362;14956.17741024254;15016.24918754058;15084.094954302776;15091;15095.849041509444;7918.960405197937;8342.29090527312;8421.663133474714;8525.616347264388;8548.615312310962;6197;7708.961455192688;7814.882776758353;8212.052078826273;8425.957870210732;6182;6709.094272273181;6759;6761.898571521431;6774.864502709918;1882.1342182596159;1906.5805522784965;1955.706644003411;1961.8430525557922;1965.1844484538756;884.7345796261096;1006.5571148694551;1026.7279171019686;1039.194624166262;1106.5352551928208;20091.39725808228;20976.580468390548;21091.367258982256;21093.261735839173;21272.36182914515;996.9750756231152;1018.4144117132678;1057.1225882517492;1057.9947100264449;1059.2214722179192;11072.889271107186;11509.539618415338;11989.700257493632;12006.159568830273;12009.699757506132;522778;524401;529045;530144;530528;100455.49772251092;102417.48791255995;102880.48559757153;102933.48533257286;103416;996.3822430093244;1001.529281237817;1019.169376957777;1029.4543891737392;1031.51003273446;15838.28727707279;17739.55651108681;17906.194221260335;18593.16330765146;18792.342268020555;42805.14389712126;43843.34234986414;44022.33966490441;44248;44728;57811;58322.708386457794;64092.679536602016;64475.67762161159;65326.713565025;8476.576171191538;8998.820023599623;9029.36794424384;9057.411268267542;9210.171084602418;13688.589342319747;13697.315134243048;14185.290735463392;14292.71414571682;14413.927930360282;12308.753824923273;12614.747705046031;12786.808197877226;12856.421461034462;12919.095663303478;12171.208871423329;12317.72122157368;12416.813747793609;12417.937910310391;12656.43046062911;12145.574904878287;12326.07554433439;12451.937740311603;12510.124291299522;12700.36498175069;7920.960395197987;8102.432829701865;8751.824963500567;8809.515476648847;8932.821343572961;8651.52416617092;12590.24458532491;12594.307313097868;12726.872731272939;12785.04112191608 23:20:05 INFO - PROCESS | 20981 | |3;mootools.html;1332.2206509192133;1468.8310844252908;1506.0361368724016;1608.9758653620197;1781.5635169383504;8168.142345053773;8519.91480085199;8559.614817333219;8737.694180703676;8756.649734010647;8454.450460720065;8674.132586741323;8701.086385929466;8709.172628600289;8714.25928796053;2046.7032280319345;2243.248511748558;2309.722833260011;2323.175272778165;2335.3461030911285;2349.142562964514;2349.788519033287;2352.023910077316;2354.058376649337;2359.0445869422824;2296.9770302297015;2300.275413244831;2336.3691803213123;2336.4275752440676;2337.567550003246;1958.7061940708866;2006.347936920492;2008.768991565974;2168.6530155175174;2222.588821068108;2286.0512887151813;2313.560423519526;2317.3395582259145;2318.7217533895873;2322.303309007291;8843.380963332569;8852.159044890725;8857.468551886908;8859.114088591154;8870.600822962982;4996.200607902754;5109.080365534202;5112.616553758483;5113.258577506241;5121.615878809104;3242.5946756655417;3298.09302441828;3361.8991430257133;3366.6969972702327;3374.4938259261307;1058.5606973106228;1079.96220132295;1107.767368852542;1107.7729065541625;1117.1398023521842;12408.193467424679;12408.56570020045;12426.813597796041;12430;12461.252324860447;4399.64802815774;4503.977480112579;4514.390557274792;4523.457185137804;4526.932096018562;10465.529051192714;10468.73828154287;10487;10503.2122590806;10515.106215971575;5047.823326183566;5055.140626093499;5062.82280120194;5064.442911279756;5069.543741063322;4128.504579450485;4502.4371953505815;4684.297355396649;4690.718556886598;4701.858944231679;3936.4095385692376;3962.821673024663;3967.3652215645357;3970.5433875104154;4057.4522439470884;1158.5944919278354;1220.5789002794022;1252.3362617812575;1306.053111494159;1319.3535167767725;992.980140397188;994.4033579852031;1014.1987829614521;1019.3527110285022;1030.8659874216303;6074.119252708332;6115.724792384353;6149.292831324366;6156.0458128989185;6241.313455519889;987.3582171588381;990.321629683669;1014.4826138669332;1018.9032041956002;1019.7304356076731;4093.7339072960162;4150.584941505826;4165.166966606691;4253.3619957006695;4280.272353699816;10779.622713205157;10925.836112458319;10957.12343012557;11058.170637202242;11067.114630829514;10917.181211409175;10926.890731092588;10941.398223097647;10948.781024379627;10955.178361622751;7860.764177074697;8176.509409435453;8178.550179740171;8245.257926786619;8345.499270043816;6139.140520327247;6266.310705822447;6298.338674439118;6298.905516417349;6336.260356203764;10304.072633463024;10344.32761870476;10375.429351385445;10537.683869483928;10576.735581610214;10331.121854642439;10535.63125290611;10678.466076695979;10723.142148628247;10730.356178629307;7899.68401263943;7936.325412340016;8015.970363454956;8097.433179677601;8114.634841432032;8581.399302048796;8607.35444841652;8621.051684314845;8632.78418039554;8666.653333866574;7348.669309880961;7423.146338170964;7547.433942454448;7562.848743025219;7781;7331.4134869209265;7412.851742965218;7458.925410745823;7585.544867307979;7724;7126.928730712627;7162.140543134858;7210.495265331377;7216.134063912364;7228.566286022856;4911.778969946433;5057.418396884405;5147.047796157723;5169;5210.843674689765;5227.398849132246;5392.083345831296;5449.809256676156;5516.889662206813;5523.28197334344 23:20:05 INFO - PROCESS | 20981 | |4;prototype.html;314.1784234227495;315.71901008102793;318.3426224845692;318.4824659927618;319.4537341146639;5371.194320851874;5376.489233522809;5383.757730902109;5387.622866399349;5403.567714582834;5269.710165940872;5302.098643230651;5308.416074231841;5310.15037593985;5321.2439894834615;4012.658923991457;4028.415879697442;4176.540580536139;4179.958200417987;4187.434696316004;4137.482814648169;4139;4154.875353739378;4157.833686652531;4167.166566686659;3984.7011474139554;4111.095558977036;4111.951452379639;4112.465379500661;4143.937840932374;4071.7149799514045;4072.735272207297;4095.9180816383805;4162.875113746592;4177.749335039907;3675.4119340905327;3685.4471829225563;3685.963140368589;3688.391415416453;3704.7962362070075;5153.974230128825;5233.685978841282;5257.7108259045735;5257.894842103136;5268.631195816294;4704.106219818258;4736.8578942631775;4740.620750339965;4747.7388743619085;4776.188048031843;5547.611667183299;5587.8882422351735;5595.38450770415;5597.788873395027;5614.578906581982;4042.595740425934;4048.473698419216;4068.4304197412384;4071.084006098634;4083;5561.138023606348;5694.572907031989;5734.856628584319;5749.425057494259;5750.166225897264;4080.510338759368;4090.4682391288943;4118.546959834416;4150.211459822624;4168.457670661814;4193.098483825992;4193.7693426861815;4205.5794420557695;4218.2196293685765;4218.388333691598;4467.463904331501;4685;4686.27362758773;4697.859064228079;4785.49752276013;5530.856303637655;5549.473894678915;5559.138333558305;5576.581756368208;5579.525740312038;1394.3655636685285;1414.519063518388;1424.266502751084;1426.686129051607;1431.1895452252909;900.2213085680839;908.981820363589;909.3725329522608;910.6539514984264;911.7128104647015;4792.688475249098;4805.8077676892535;4810.4467986182035;4911.2810516319005;4938.8765280868265;5050.535344749981;5067.847964561069;5130.974345128325;5143.254228136974;5188.558972487305;4818.229083346648;4820.9517904821205;4847.975760121177;5112.130937740593;5557.888842223214;3041.14132715247;3055.4805683033937;3066.2794243352796;3068.4170007698467;3071.585335979659;5981;6003.339632640406;6004.279486461653;6006.12911127884;6045.486133678599;5559.861003474945;5837.591368604157;5837.6497410155525;5850.4788754923175;5873.823785286449;5931.0344827586205;5939.693267481147;5961.940380596226;5994;6010.459058684739;5597.132444471114;5650.830475085754;5779.913301300399;5780.624259423124;5799.188113664006;5712.65724056558;5731.541476681772;5740.13897915316;5747.281589801275;5757.625754325955;5861.443162899518;5960.433758792908;5966.373530779206;6002.639841609517;6015.939840601538;3833.3291673957506;4031.67746580267;4036.8990775230855;4038.7980600970423;4043.2317859606583;5516.641418307797;5638.887222255614;5704.258446402107;5733.913991290217;5745.396733342939;5593.720313984366;5603.971980140073;5613.691246981455;5621.381648018796;5638.746256418389;5553.555715542666;5569.972150139385;5573.7770489179975;5574.637648552994;5581.469760372758;5297.284866542967;5513.145462453166;5530.529904958124;5556.138798486241;5561;5562.193481945176;5582.023145949362;5612;5643.181738647955;5653.321601407857;5286.841394758163;5554.888902221852;5557.277553917965;5579.609427340048;5608.859778505407 23:20:05 INFO - PROCESS | 20981 | |5;yui.html;732.8534293141373;736.1276886889041;768.727101878833;784.0043145205589;868.9391742578018;14764.261786910653;15932;15944.760828587552;15961.12213828239;16049.438269660564;15124.924375378108;15130.092194468312;15290.617734556614;15314.770278445805;16268.349266029374;650.9772157974472;799.0411506192563;815.095244278853;817.6851912013888;818.1205204405259;739.9963000184991;781.601383294521;783.8706613408809;788.0976282156927;790.6363072986433;843.6541018182546;844.7085755414403;847.4110493207223;847.5677404523707;848.088305072047;680.4556354916048;801.0827602395283;848.0120659431755;848.3255811629738;848.4866655673352;616.1866336435861;617.7158507086746;618.0852338538942;618.2086928731231;618.3105836991767;15972.121533315663;15991.520254392386;16081.437149699705;16104.275307611186;16105.43630972922;14467.348969296407;14639.780403293958;14648.560543183616;14716.852831471655;14765.630859228606;13159.60521184366;13253.86746132536;13310.667233319244;13661.043726939119;14206.289685515787;4283.100548884738;4331.285337919239;4399.406080179167;4415.889602759925;4540.591346778772;84609.15390846075;85032;85472.57263713641;86174.13825861724;86578;11432.634269065276;11626.709332266591;11667.183297169116;11681.299122052704;11824.290542567473;21517.462063448227;21525.031373588226;21527.67708484374;21532.354029379145;21533.46166345854;8728.519931403835;8736.432131911406;8779.912200878038;8823.441441261848;8937.150970657776;4814.711117332971;4840.491748366441;4957.851264462072;4959.479254678279;5083.085044691991;3425.6916877481144;3534.2048039190977;3539.840707168132;3544.503769472276;3547.4324108142573;585.3853453873415;598.9041753319535;604.2205554834214;613.9877202455926;617.478230894893;683.5420268420171;710.8045287545863;711.4557363616838;713.3472872321871;721.8051126196003;8258.42191046633;8595.3553483489;9104.499252541174;9865.901340986642;10064.849027264598;636.4780879678711;667.9613201471758;711.7508871894795;712.5119293284117;713.5433322673493;4721.834735784231;4927.605791536668;4939.53074457926;4940.629452791055;5005.299258103868;82222.17777822145;92942;130698.34650826875;133041;133060;109159.45420272848;109182.45408772906;109357;110048.4497577507;110137;60703.392966070656;87054;92685.5365723167;94287;96181.51909240549;8876.556172191495;8935.955320223356;8995;9002.189802917506;9285.396449230779;56131.14164017123;56151;56297.155542667715;57742.13386799285;58930.70534647299;75935.62032190025;76173.61913190398;84885.57557212174;84896.5755171245;85847;11307.208495405243;11389.772204556028;11459.713507162387;11823.881761182278;12152.331621760888;13053.804192936923;13142;13145.474181033034;13235.867641323848;13811.654708632364;12374.876251237372;12605.74788504243;12630.747385052431;12712.237265764084;12754.48982040745;12601.306928118674;12699.174553653984;12981;13357.53248636293;13376.264305463294;12364.62906112818;12455.564055258023;12816.590175080548;12945;13000.674983125498;10458.529366178387;10670.73323166927;10844.132469402271;10850.728731781768;11016.17378696585;10674.8932510677;10701.785964280827;10756.872723644228;10854.620088296871;10883.183761217782 23:20:05 INFO - PROCESS | 20981 | __end_tp_report 23:20:05 INFO - PROCESS | 20981 | __start_cc_report 23:20:05 INFO - PROCESS | 20981 | _x_x_mozilla_cycle_collect,806 23:20:05 INFO - PROCESS | 20981 | __end_cc_report 23:20:05 INFO - PROCESS | 20981 | __startTimestamp1467958805013__endTimestamp 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | ------- Summary: start ------- 23:20:05 INFO - PROCESS | 20981 | Number of tests: 6 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | [#0] dojo.html Cycles:165 Average:5159.01 Median:5347.12 stddev:568.83 (10.6%) stddev-sans-first:544.54 23:20:05 INFO - PROCESS | 20981 | Values: 2990.3 2991.8 3018.7 3021.9 3031.1 5087.8 5110.5 5147.8 5229.3 5257.2 5184.9 5187.4 5198.9 5222.0 5259.2 4671.2 4736.8 4762.0 4766.6 4913.0 4809.1 4837.1 4877.1 4893.0 4903.2 4648.6 4679.8 4688.6 4693.3 4709.9 4688.2 4702.1 4777.4 4785.5 4807.2 4735.9 4738.1 4765.8 4779.0 4803.7 5061.3 5101.9 5123.3 5177.2 5197.3 5473.6 5481.6 5507.9 5513.9 5523.7 5398.4 5546.7 5566.8 5571.2 5574.1 5134.2 5181.6 5186.6 5201.2 5211.9 5653.7 5717.7 5720.5 5721.2 5729.5 5282.0 5308.5 5421.0 5440.5 5444.0 5473.0 5524.3 5524.7 5546.8 5558.4 5509.3 5514.8 5515.1 5515.1 5520.4 5358.1 5506.8 5515.9 5521.8 5554.9 4287.6 4299.2 4304.2 4343.2 4344.4 3800.6 3829.3 3831.9 3872.3 3874.4 5216.8 5229.9 5245.8 5333.7 5347.3 5567.8 5578.5 5611.0 5614.2 5669.6 5304.7 5310.7 5318.9 5320.1 5378.3 4705.6 4774.0 4806.4 4835.2 4850.6 5786.4 5794.6 5794.7 5798.8 5825.1 5550.6 5562.8 5564.0 5572.1 5575.4 5616.8 5688.0 5717.8 5745.0 5795.4 5467.7 5475.6 5480.5 5481.9 5482.1 5537.0 5560.5 5579.5 5587.1 5631.9 5306.2 5306.7 5323.4 5347.1 5367.4 5354.1 5355.9 5360.2 5365.7 5367.9 5254.0 5267.3 5316.1 5320.7 5356.8 5349.8 5374.0 5422.9 5424.8 5511.5 5347.7 5351.8 5352.4 5355.1 5355.4 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | [#1] ext.html Cycles:180 Average:59551.40 Median:37587.53 stddev:116162.82 (309.0%) stddev-sans-first:116404.35 23:20:05 INFO - PROCESS | 20981 | Values: 593.9 605.2 618.5 631.1 644.2 32192.4 42455.4 43178.0 43225.0 43406.3 44264.8 44335.0 44597.0 44801.0 44863.8 7987.7 8857.0 8968.8 8994.6 10559.9 10477.9 10851.2 10862.1 10866.8 10867.6 10845.1 10892.9 10897.8 10905.5 10911.3 8050.0 8227.2 10466.7 10720.5 10795.6 10604.8 10647.1 10670.4 10677.1 10684.0 41997.4 42296.0 42569.0 42575.6 42658.8 2742.8 3327.5 3664.7 3706.7 3798.5 30787.8 32432.4 32719.7 33432.7 34016.7 4464.8 4545.2 4557.5 4579.0 4776.2 353987.0 354365.0 354610.2 355064.0 356367.0 60149.7 60386.7 60748.4 60828.4 60964.0 34456.3 34983.0 35141.3 37251.3 62021.0 16893.2 17051.7 17135.2 17139.0 17141.3 12571.6 12718.6 12730.5 12731.4 12741.2 19281.6 19446.0 19503.8 19558.4 19591.6 5940.4 7071.5 7285.5 7330.9 7331.2 916.9 1095.6 1115.6 1174.8 1193.9 31703.0 32719.7 32869.7 32892.3 33381.5 1083.0 1090.8 1115.5 1145.5 1179.5 16876.2 17351.3 17354.6 17363.6 17425.4 543462.0 547786.0 549125.0 550320.0 550440.0 56759.4 58007.4 58127.4 58146.1 58150.1 1203.9 1296.8 1324.3 1344.4 1374.7 30528.4 33301.0 33327.2 33583.0 33586.2 48688.5 49110.5 49132.0 49238.8 49247.0 381595.0 388382.0 390499.0 390961.0 391169.0 24141.0 24592.6 44577.3 45546.3 47024.0 46540.0 49436.3 49629.0 50093.0 50723.2 41569.8 42098.0 42632.1 43442.1 43546.6 42496.0 42568.6 42883.8 43667.3 44101.0 41490.8 42254.8 42318.6 42364.4 42600.4 36353.0 37336.4 37838.6 38229.0 38451.0 28598.6 28823.9 28909.4 29117.4 29125.7 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | [#2] jquery.html Cycles:180 Average:30847.66 Median:23090.21 stddev:86958.37 (376.6%) stddev-sans-first:87172.22 23:20:05 INFO - PROCESS | 20981 | Values: 382.2 384.8 389.0 399.6 421.1 13291.0 19366.2 20076.4 20082.9 21039.8 15763.6 18009.5 18701.0 18739.7 19331.9 5843.1 6007.5 6008.0 6008.3 6016.8 5792.2 5906.5 5910.9 5945.1 5955.7 5755.3 5797.0 5826.9 5886.4 5888.7 5741.5 5817.6 5823.7 5840.3 5849.7 5133.2 5239.7 5247.5 5254.0 5261.4 22973.8 23206.7 24189.6 24217.0 24247.3 2471.0 2535.9 2628.8 2643.0 2846.4 14788.4 14958.4 15012.9 15241.8 15367.2 1951.9 1962.1 1963.3 2040.0 2061.7 79222.2 80510.0 80664.0 81268.6 82061.2 9941.9 10081.3 10741.2 10949.8 10974.1 14956.2 15016.2 15084.1 15091.0 15095.8 7919.0 8342.3 8421.7 8525.6 8548.6 6197.0 7709.0 7814.9 8212.1 8426.0 6182.0 6709.1 6759.0 6761.9 6774.9 1882.1 1906.6 1955.7 1961.8 1965.2 884.7 1006.6 1026.7 1039.2 1106.5 20091.4 20976.6 21091.4 21093.3 21272.4 997.0 1018.4 1057.1 1058.0 1059.2 11072.9 11509.5 11989.7 12006.2 12009.7 522778.0 524401.0 529045.0 530144.0 530528.0 100455.5 102417.5 102880.5 102933.5 103416.0 996.4 1001.5 1019.2 1029.5 1031.5 15838.3 17739.6 17906.2 18593.2 18792.3 42805.1 43843.3 44022.3 44248.0 44728.0 57811.0 58322.7 64092.7 64475.7 65326.7 8476.6 8998.8 9029.4 9057.4 9210.2 13688.6 13697.3 14185.3 14292.7 14413.9 12308.8 12614.7 12786.8 12856.4 12919.1 12171.2 12317.7 12416.8 12417.9 12656.4 12145.6 12326.1 12451.9 12510.1 12700.4 7921.0 8102.4 8751.8 8809.5 8932.8 8651.5 12590.2 12594.3 12726.9 12785.0 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | [#3] mootools.html Cycles:180 Average:5826.22 Median:4266.82 stddev:3350.15 (78.5%) stddev-sans-first:3342.52 23:20:05 INFO - PROCESS | 20981 | Values: 1332.2 1468.8 1506.0 1609.0 1781.6 8168.1 8519.9 8559.6 8737.7 8756.6 8454.5 8674.1 8701.1 8709.2 8714.3 2046.7 2243.2 2309.7 2323.2 2335.3 2349.1 2349.8 2352.0 2354.1 2359.0 2297.0 2300.3 2336.4 2336.4 2337.6 1958.7 2006.3 2008.8 2168.7 2222.6 2286.1 2313.6 2317.3 2318.7 2322.3 8843.4 8852.2 8857.5 8859.1 8870.6 4996.2 5109.1 5112.6 5113.3 5121.6 3242.6 3298.1 3361.9 3366.7 3374.5 1058.6 1080.0 1107.8 1107.8 1117.1 12408.2 12408.6 12426.8 12430.0 12461.3 4399.6 4504.0 4514.4 4523.5 4526.9 10465.5 10468.7 10487.0 10503.2 10515.1 5047.8 5055.1 5062.8 5064.4 5069.5 4128.5 4502.4 4684.3 4690.7 4701.9 3936.4 3962.8 3967.4 3970.5 4057.5 1158.6 1220.6 1252.3 1306.1 1319.4 993.0 994.4 1014.2 1019.4 1030.9 6074.1 6115.7 6149.3 6156.0 6241.3 987.4 990.3 1014.5 1018.9 1019.7 4093.7 4150.6 4165.2 4253.4 4280.3 10779.6 10925.8 10957.1 11058.2 11067.1 10917.2 10926.9 10941.4 10948.8 10955.2 7860.8 8176.5 8178.6 8245.3 8345.5 6139.1 6266.3 6298.3 6298.9 6336.3 10304.1 10344.3 10375.4 10537.7 10576.7 10331.1 10535.6 10678.5 10723.1 10730.4 7899.7 7936.3 8016.0 8097.4 8114.6 8581.4 8607.4 8621.1 8632.8 8666.7 7348.7 7423.1 7547.4 7562.8 7781.0 7331.4 7412.9 7458.9 7585.5 7724.0 7126.9 7162.1 7210.5 7216.1 7228.6 4911.8 5057.4 5147.0 5169.0 5210.8 5227.4 5392.1 5449.8 5516.9 5523.3 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | [#4] prototype.html Cycles:180 Average:4669.14 Median:5292.06 stddev:1376.93 (26.0%) stddev-sans-first:1341.43 23:20:05 INFO - PROCESS | 20981 | Values: 314.2 315.7 318.3 318.5 319.5 5371.2 5376.5 5383.8 5387.6 5403.6 5269.7 5302.1 5308.4 5310.2 5321.2 4012.7 4028.4 4176.5 4180.0 4187.4 4137.5 4139.0 4154.9 4157.8 4167.2 3984.7 4111.1 4112.0 4112.5 4143.9 4071.7 4072.7 4095.9 4162.9 4177.7 3675.4 3685.4 3686.0 3688.4 3704.8 5154.0 5233.7 5257.7 5257.9 5268.6 4704.1 4736.9 4740.6 4747.7 4776.2 5547.6 5587.9 5595.4 5597.8 5614.6 4042.6 4048.5 4068.4 4071.1 4083.0 5561.1 5694.6 5734.9 5749.4 5750.2 4080.5 4090.5 4118.5 4150.2 4168.5 4193.1 4193.8 4205.6 4218.2 4218.4 4467.5 4685.0 4686.3 4697.9 4785.5 5530.9 5549.5 5559.1 5576.6 5579.5 1394.4 1414.5 1424.3 1426.7 1431.2 900.2 909.0 909.4 910.7 911.7 4792.7 4805.8 4810.4 4911.3 4938.9 5050.5 5067.8 5131.0 5143.3 5188.6 4818.2 4821.0 4848.0 5112.1 5557.9 3041.1 3055.5 3066.3 3068.4 3071.6 5981.0 6003.3 6004.3 6006.1 6045.5 5559.9 5837.6 5837.6 5850.5 5873.8 5931.0 5939.7 5961.9 5994.0 6010.5 5597.1 5650.8 5779.9 5780.6 5799.2 5712.7 5731.5 5740.1 5747.3 5757.6 5861.4 5960.4 5966.4 6002.6 6015.9 3833.3 4031.7 4036.9 4038.8 4043.2 5516.6 5638.9 5704.3 5733.9 5745.4 5593.7 5604.0 5613.7 5621.4 5638.7 5553.6 5570.0 5573.8 5574.6 5581.5 5297.3 5513.1 5530.5 5556.1 5561.0 5562.2 5582.0 5612.0 5643.2 5653.3 5286.8 5554.9 5557.3 5579.6 5608.9 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - PROCESS | 20981 | [#5] yui.html Cycles:180 Average:21639.03 Median:4827.60 stddev:32008.39 (663.0%) stddev-sans-first:32059.69 23:20:05 INFO - PROCESS | 20981 | Values: 732.9 736.1 768.7 784.0 868.9 14764.3 15932.0 15944.8 15961.1 16049.4 15124.9 15130.1 15290.6 15314.8 16268.3 651.0 799.0 815.1 817.7 818.1 740.0 781.6 783.9 788.1 790.6 843.7 844.7 847.4 847.6 848.1 680.5 801.1 848.0 848.3 848.5 616.2 617.7 618.1 618.2 618.3 15972.1 15991.5 16081.4 16104.3 16105.4 14467.3 14639.8 14648.6 14716.9 14765.6 13159.6 13253.9 13310.7 13661.0 14206.3 4283.1 4331.3 4399.4 4415.9 4540.6 84609.2 85032.0 85472.6 86174.1 86578.0 11432.6 11626.7 11667.2 11681.3 11824.3 21517.5 21525.0 21527.7 21532.4 21533.5 8728.5 8736.4 8779.9 8823.4 8937.2 4814.7 4840.5 4957.9 4959.5 5083.1 3425.7 3534.2 3539.8 3544.5 3547.4 585.4 598.9 604.2 614.0 617.5 683.5 710.8 711.5 713.3 721.8 8258.4 8595.4 9104.5 9865.9 10064.8 636.5 668.0 711.8 712.5 713.5 4721.8 4927.6 4939.5 4940.6 5005.3 82222.2 92942.0 130698.3 133041.0 133060.0 109159.5 109182.5 109357.0 110048.4 110137.0 60703.4 87054.0 92685.5 94287.0 96181.5 8876.6 8936.0 8995.0 9002.2 9285.4 56131.1 56151.0 56297.2 57742.1 58930.7 75935.6 76173.6 84885.6 84896.6 85847.0 11307.2 11389.8 11459.7 11823.9 12152.3 13053.8 13142.0 13145.5 13235.9 13811.7 12374.9 12605.7 12630.7 12712.2 12754.5 12601.3 12699.2 12981.0 13357.5 13376.3 12364.6 12455.6 12816.6 12945.0 13000.7 10458.5 10670.7 10844.1 10850.7 11016.2 10674.9 10701.8 10756.9 10854.6 10883.2 23:20:05 INFO - PROCESS | 20981 | -------- Summary: end -------- 23:20:05 INFO - PROCESS | 20981 | 23:20:05 INFO - TEST-INFO | 20981: exit 0 23:20:05 INFO - TEST-OK | dromaeo_css | took 1113134ms 23:20:05 INFO - TEST-START | kraken 23:20:05 INFO - operating with platform_type : linux_ 23:20:05 INFO - Initialising browser for kraken test... 23:20:05 INFO - TEST-INFO | started process 21180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp12_861/profile http://localhost:43823/getInfo.html) 23:20:09 INFO - PROCESS | 21180 | __metrics Screen width/height:1600/1200 23:20:09 INFO - PROCESS | 21180 | colorDepth:24 23:20:09 INFO - PROCESS | 21180 | Browser inner width/height: 1024/697 23:20:09 INFO - PROCESS | 21180 | __metrics 23:20:10 INFO - PROCESS | 21180 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:20:11 INFO - TEST-INFO | 21180: exit 0 23:20:11 INFO - Browser initialized. 23:20:11 INFO - Running cycle 1/1 for kraken test... 23:20:11 INFO - TEST-INFO | started process 21265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp12_861/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:23 INFO - PROCESS | 21265 | RSS: Main: 157089792 23:20:23 INFO - PROCESS | 21265 | 23:20:25 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43823/tests/kraken/driver.html?testName=audio-beat-detection) 23:20:26 INFO - PROCESS | 21265 | RSS: Main: 215937024 23:20:26 INFO - PROCESS | 21265 | 23:20:29 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43823/tests/kraken/driver.html?testName=audio-dft) 23:20:29 INFO - PROCESS | 21265 | RSS: Main: 203173888 23:20:29 INFO - PROCESS | 21265 | 23:20:33 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43823/tests/kraken/driver.html?testName=audio-fft) 23:20:33 INFO - PROCESS | 21265 | RSS: Main: 269451264 23:20:33 INFO - PROCESS | 21265 | 23:20:35 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43823/tests/kraken/driver.html?testName=audio-oscillator) 23:20:36 INFO - PROCESS | 21265 | RSS: Main: 181219328 23:20:36 INFO - PROCESS | 21265 | 23:20:38 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:20:39 INFO - PROCESS | 21265 | RSS: Main: 184623104 23:20:39 INFO - PROCESS | 21265 | 23:20:42 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43823/tests/kraken/driver.html?testName=imaging-darkroom) 23:20:42 INFO - PROCESS | 21265 | RSS: Main: 219131904 23:20:42 INFO - PROCESS | 21265 | 23:20:46 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43823/tests/kraken/driver.html?testName=imaging-desaturate) 23:20:46 INFO - PROCESS | 21265 | RSS: Main: 221749248 23:20:46 INFO - PROCESS | 21265 | 23:20:49 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43823/tests/kraken/driver.html?testName=json-parse-financial) 23:20:50 INFO - PROCESS | 21265 | RSS: Main: 220745728 23:20:50 INFO - PROCESS | 21265 | 23:20:51 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:20:52 INFO - PROCESS | 21265 | RSS: Main: 206512128 23:20:52 INFO - PROCESS | 21265 | 23:20:53 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:20:54 INFO - PROCESS | 21265 | RSS: Main: 211038208 23:20:54 INFO - PROCESS | 21265 | 23:20:56 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:20:57 INFO - PROCESS | 21265 | RSS: Main: 207069184 23:20:57 INFO - PROCESS | 21265 | 23:20:59 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:21:00 INFO - PROCESS | 21265 | RSS: Main: 222367744 23:21:00 INFO - PROCESS | 21265 | 23:21:03 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:21:03 INFO - PROCESS | 21265 | RSS: Main: 223129600 23:21:03 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:43823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43823/tests/kraken/driver.html?testName=ai-astar) 23:21:05 INFO - PROCESS | 21265 | RSS: Main: 266354688 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | __start_tp_report 23:21:05 INFO - PROCESS | 21265 | _x_x_mozilla_page_load 23:21:05 INFO - PROCESS | 21265 | _x_x_mozilla_page_load_details 23:21:05 INFO - PROCESS | 21265 | |i|pagename|runs| 23:21:05 INFO - PROCESS | 21265 | |0;ai-astar;104;111;113;112;112;111;111;111;109;110 23:21:05 INFO - PROCESS | 21265 | |1;audio-beat-detection;152;119;119;168;117;122;150;117;149;117 23:21:05 INFO - PROCESS | 21265 | |2;audio-dft;163;162;160;162;162;161;163;161;162;162 23:21:05 INFO - PROCESS | 21265 | |3;audio-fft;74;75;75;114;76;75;74;76;100;75 23:21:05 INFO - PROCESS | 21265 | |4;audio-oscillator;84;84;122;85;84;85;126;84;85;139 23:21:05 INFO - PROCESS | 21265 | |5;imaging-gaussian-blur;117;117;116;116;117;116;116;117;118;117 23:21:05 INFO - PROCESS | 21265 | |6;imaging-darkroom;146;147;146;146;146;145;145;145;146;145 23:21:05 INFO - PROCESS | 21265 | |7;imaging-desaturate;95;96;95;97;95;95;96;96;95;95 23:21:05 INFO - PROCESS | 21265 | |8;json-parse-financial;53;54;52;52;52;51;53;53;52;53 23:21:05 INFO - PROCESS | 21265 | |9;json-stringify-tinderbox;61;61;63;63;62;63;62;61;61;66 23:21:05 INFO - PROCESS | 21265 | |10;stanford-crypto-aes;78;74;73;74;75;75;74;74;73;80 23:21:05 INFO - PROCESS | 21265 | |11;stanford-crypto-ccm;119;118;126;120;121;119;121;124;171;133 23:21:05 INFO - PROCESS | 21265 | |12;stanford-crypto-pbkdf2;158;157;158;157;158;156;157;157;157;159 23:21:05 INFO - PROCESS | 21265 | |13;stanford-crypto-sha256-iterative;65;64;67;64;64;62;64;63;64;67 23:21:05 INFO - PROCESS | 21265 | __end_tp_report 23:21:05 INFO - PROCESS | 21265 | __start_cc_report 23:21:05 INFO - PROCESS | 21265 | _x_x_mozilla_cycle_collect,1656 23:21:05 INFO - PROCESS | 21265 | __end_cc_report 23:21:05 INFO - PROCESS | 21265 | __startTimestamp1467958865615__endTimestamp 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | ------- Summary: start ------- 23:21:05 INFO - PROCESS | 21265 | Number of tests: 14 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.50 (2.3%) stddev-sans-first:1.17 23:21:05 INFO - PROCESS | 21265 | Values: 104.0 111.0 113.0 112.0 112.0 111.0 111.0 111.0 109.0 110.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:135.50 stddev:19.47 (14.4%) stddev-sans-first:19.40 23:21:05 INFO - PROCESS | 21265 | Values: 152.0 119.0 119.0 168.0 117.0 122.0 150.0 117.0 149.0 117.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 23:21:05 INFO - PROCESS | 21265 | Values: 163.0 162.0 160.0 162.0 162.0 161.0 163.0 161.0 162.0 162.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:13.91 (18.5%) stddev-sans-first:14.49 23:21:05 INFO - PROCESS | 21265 | Values: 74.0 75.0 75.0 114.0 76.0 75.0 74.0 76.0 100.0 75.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:84.00 stddev:21.94 (26.1%) stddev-sans-first:22.69 23:21:05 INFO - PROCESS | 21265 | Values: 84.0 84.0 122.0 85.0 84.0 85.0 126.0 84.0 85.0 139.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 23:21:05 INFO - PROCESS | 21265 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 118.0 117.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:21:05 INFO - PROCESS | 21265 | Values: 146.0 147.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 23:21:05 INFO - PROCESS | 21265 | Values: 95.0 96.0 95.0 97.0 95.0 95.0 96.0 96.0 95.0 95.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 23:21:05 INFO - PROCESS | 21265 | Values: 53.0 54.0 52.0 52.0 52.0 51.0 53.0 53.0 52.0 53.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:1.57 (2.5%) stddev-sans-first:1.59 23:21:05 INFO - PROCESS | 21265 | Values: 61.0 61.0 63.0 63.0 62.0 63.0 62.0 61.0 61.0 66.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:2.26 (3.0%) stddev-sans-first:2.12 23:21:05 INFO - PROCESS | 21265 | Values: 78.0 74.0 73.0 74.0 75.0 75.0 74.0 74.0 73.0 80.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:122.50 stddev:16.03 (13.1%) stddev-sans-first:16.72 23:21:05 INFO - PROCESS | 21265 | Values: 119.0 118.0 126.0 120.0 121.0 119.0 121.0 124.0 171.0 133.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:157.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 23:21:05 INFO - PROCESS | 21265 | Values: 158.0 157.0 158.0 157.0 158.0 156.0 157.0 157.0 157.0 159.0 23:21:05 INFO - PROCESS | 21265 | 23:21:05 INFO - PROCESS | 21265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:1.58 (2.5%) stddev-sans-first:1.66 23:21:05 INFO - PROCESS | 21265 | Values: 65.0 64.0 67.0 64.0 64.0 62.0 64.0 63.0 64.0 67.0 23:21:05 INFO - PROCESS | 21265 | -------- Summary: end -------- 23:21:05 INFO - PROCESS | 21265 | 23:21:06 INFO - TEST-INFO | 21265: exit 0 23:21:06 INFO - TEST-OK | kraken | took 60825ms 23:21:06 INFO - SUITE-END | took 1173s 23:21:06 INFO - Completed test suite (00:19:34) 23:21:06 INFO - javascript benchmark 23:21:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2990.2673844908, 2991.820490770554, 3018.6981301869814, 3021.864016119274, 3031.075521965801, 5087.847364579068, 5110.514501122397, 5147.845564633062, 5229.267902493649, 5257.185136303879, 5184.8703782405455, 5187.377514698242, 5198.896022079556, 5222.007818514479, 5259.211118332252, 4671.20589499785, 4736.834210802623, 4761.999980004186, 4766.642501812361, 4913.041956818422, 4809.110314591794, 4837.129316722989, 4877.146499362615, 4892.9510704892855, 4903.19097348937, 4648.558386953251, 4679.8362057328, 4688.624910007208, 4693.342931989524, 4709.858704238878, 4688.156131896258, 4702.106599746037, 4777.402824646919, 4785.521447855222, 4807.230843065127, 4735.881602959919, 4738.0523895221095, 4765.809367625291, 4779.0, 4803.7357945313, 5061.266116413136, 5101.948980510185, 5123.308353372285, 5177.197534382177, 5197.272381866542, 5473.589480788917, 5481.643693159932, 5507.889842203133, 5513.9448605514235, 5523.696196709179, 5398.433164517708, 5546.722663866791, 5566.777328906839, 5571.164325351189, 5574.080276754331, 5134.229865520165, 5181.559567436772, 5186.636935414523, 5201.24581935621, 5211.9478805211465, 5653.717314134359, 5717.714114294268, 5720.542356611461, 5721.22763426932, 5729.455701708331, 5282.0, 5308.495692909168, 5421.0, 5440.455954404528, 5443.972780136074, 5472.972635136799, 5524.254225679562, 5524.696141712164, 5546.833594992157, 5558.416366281563, 5509.311336082989, 5514.80698175562, 5515.062439385234, 5515.145152501369, 5520.365158006881, 5358.089124848785, 5506.807261745819, 5515.862103447365, 5521.806736764194, 5554.91667624986, 4287.571242875688, 4299.226139294957, 4304.225239456928, 4343.19650864591, 4344.413504176959, 3800.638939300762, 3829.310724069694, 3831.9042023949623, 3872.2642697887313, 3874.360730479439, 5216.817411390659, 5229.895402091937, 5245.816396426107, 5333.653312534673, 5347.25138480613, 5567.777288908398, 5578.525825304894, 5611.0, 5614.185943038318, 5669.574781891375, 5304.655197412156, 5310.734463276821, 5318.9202161967605, 5320.122179840283, 5378.273933019071, 4705.60002399793, 4774.0, 4806.399200099988, 4835.153848076572, 4850.611951043908, 5786.392428795, 5794.565407594448, 5794.739236734273, 5798.82603521895, 5825.097109947965, 5550.611457197957, 5562.805301814417, 5563.972180139235, 5572.108462645957, 5575.358833734173, 5616.803411880564, 5688.0, 5717.828465146053, 5744.971275143597, 5795.449432303924, 5467.699276539828, 5475.589330800126, 5480.451954804487, 5481.945180548143, 5482.095454250164, 5537.031019571639, 5560.527355174855, 5579.525740312119, 5587.106063029895, 5631.915521267266, 5306.230596563554, 5306.681599104066, 5323.3878104016985, 5347.117725575236, 5367.409584945731, 5354.143337066051, 5355.919661205163, 5360.16917377807, 5365.7048862311385, 5367.919481207707, 5254.0, 5267.341582302212, 5316.0696878046965, 5320.680759154463, 5356.758945847524, 5349.7860085597695, 5374.0, 5422.9186562202385, 5424.7558859850615, 5511.5039646432015, 5347.705876176692, 5351.785928562969, 5352.41123476425, 5355.143177091647, 5355.357357117171], "value": 5121.520621986065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8812237552488, 605.2313561776543, 618.4866560754574, 631.0597210156866, 644.214058848205, 32192.356152876928, 42455.36316955248, 43178.0, 43225.0, 43406.34890476641, 44264.77867610657, 44335.0, 44597.0, 44801.0, 44863.77568112163, 7987.680492780281, 8857.0, 8968.820623587524, 8994.64021439145, 10559.947200264027, 10477.947610261937, 10851.186161037915, 10862.076723478514, 10866.836997445045, 10867.619633312836, 10845.0781683557, 10892.891071089307, 10897.782044359108, 10905.454727263645, 10911.345319280868, 8049.959750201241, 8227.218414250636, 10466.68599942003, 10720.463976801208, 10795.622153224638, 10604.840927386096, 10647.09499692527, 10670.35977841332, 10677.145828333714, 10684.038436540748, 41997.370039449124, 42296.0, 42569.0, 42575.57424425747, 42658.78670606627, 2742.835429874214, 3327.45097058985, 3664.706823454117, 3706.721995850295, 3798.487204227449, 30787.846060769552, 32432.351352972808, 32719.6728032719, 33432.66567334344, 34016.65983340184, 4464.754438505881, 4545.20458919691, 4557.496026311309, 4578.954210457886, 4776.188048031843, 353987.0, 354365.0, 354610.2269488662, 355064.0, 356367.0, 60149.699251503465, 60386.69806651027, 60748.39251607516, 60828.391716083155, 60964.0, 34456.31087378289, 34983.0, 35141.29717405637, 37251.25497490035, 62021.0, 16893.155342233084, 17051.658966820843, 17135.22891469887, 17139.0, 17141.314347426214, 12571.622851314476, 12718.554850580185, 12730.490780368867, 12731.427085781163, 12741.17182383142, 19281.57911707923, 19446.0, 19503.829770213833, 19558.381664454122, 19591.60816783685, 5940.405959404112, 7071.469639777038, 7285.526440781438, 7330.853382932311, 7331.230220826843, 916.9037251088673, 1095.6220104064084, 1115.570505355444, 1174.8061569841052, 1193.9223950443193, 31703.0, 32719.672803271664, 32869.67130328714, 32892.3421531568, 33381.499277510855, 1082.9620963266248, 1090.7654854206385, 1115.5482029777952, 1145.4616330324734, 1179.510503141204, 16876.24056917417, 17351.30594776195, 17354.566135846704, 17363.56591085233, 17425.39011134604, 543462.0, 547786.0, 549125.0, 550320.0, 550440.0, 56759.43240567624, 58007.419925800205, 58127.418725812204, 58146.127808082914, 58150.12774808381, 1203.8615559210627, 1296.8184454176424, 1324.2782683437742, 1344.4017412251649, 1374.731927274192, 30528.389432211676, 33301.0, 33327.166820829676, 33583.0, 33586.16034599154, 48688.51311486981, 49110.508894912025, 49132.0, 49238.75380623217, 49247.0, 381595.0, 388382.0, 390499.0, 390961.0, 391169.0, 24141.034358626162, 24592.631110533715, 44577.331340029275, 45546.31680524861, 47024.0, 46540.0, 49436.258456122465, 49629.044514658475, 50093.0, 50723.23915141202, 41569.752907412825, 42098.0, 42632.14735705207, 43442.131157377305, 43546.564534355515, 42496.02527823023, 42568.5743142577, 42883.7855810719, 43667.344989824545, 44101.0, 41490.792546037075, 42254.78872605618, 42318.57681423146, 42364.36453453262, 42600.36099458449, 36353.0, 37336.43995340126, 37838.62161378351, 38229.0, 38451.0, 28598.57102143428, 28823.85588072046, 28909.421811563232, 29117.417651647273, 29125.7087429123], "value": 20596.335189453184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.2469734622793, 384.77682943892546, 388.9630485103914, 399.55649229355413, 421.1282644925005, 13290.986422986203, 19366.225350985944, 20076.397708068762, 20082.89958550207, 21039.789602103974, 15763.605909852231, 18009.459716208534, 18701.0, 18739.718904216414, 19331.903340483277, 5843.094320380348, 6007.519398448136, 6007.969960150193, 6008.3390827009, 6016.8495787605225, 5792.189093526909, 5906.527477801787, 5910.911336329958, 5945.078512830518, 5955.672438015908, 5755.280589926259, 5796.971015144918, 5826.883462330751, 5886.352501224862, 5888.7055647217685, 5741.45456181662, 5817.592768506206, 5823.650580965134, 5840.299164100293, 5849.678267695275, 5133.230015497668, 5239.659422137549, 5247.475252474722, 5254.0, 5261.421243663194, 22973.77026229733, 23206.65190022151, 24189.637155442684, 24217.0, 24247.272581822574, 2470.9752902470923, 2535.911243106501, 2628.8422694638384, 2642.973570264292, 2846.388026574276, 14788.40846366144, 14958.40166393343, 15012.924935375253, 15241.847581524155, 15367.15480648564, 1951.8926459044746, 1962.1268535501708, 1963.3324669612257, 2039.9596205934931, 2061.670132778763, 79222.20777792206, 80510.0, 80664.0, 81268.59365703193, 82061.17938820596, 9941.850872236922, 10081.294309398418, 10741.24811263204, 10949.83575246372, 10974.122070234362, 14956.17741024254, 15016.24918754058, 15084.094954302776, 15091.0, 15095.849041509444, 7918.960405197937, 8342.29090527312, 8421.663133474714, 8525.616347264388, 8548.615312310962, 6197.0, 7708.961455192688, 7814.882776758353, 8212.052078826273, 8425.957870210732, 6182.0, 6709.094272273181, 6759.0, 6761.898571521431, 6774.864502709918, 1882.1342182596159, 1906.5805522784965, 1955.706644003411, 1961.8430525557922, 1965.1844484538756, 884.7345796261096, 1006.5571148694551, 1026.7279171019686, 1039.194624166262, 1106.5352551928208, 20091.39725808228, 20976.580468390548, 21091.367258982256, 21093.261735839173, 21272.36182914515, 996.9750756231152, 1018.4144117132678, 1057.1225882517492, 1057.9947100264449, 1059.2214722179192, 11072.889271107186, 11509.539618415338, 11989.700257493632, 12006.159568830273, 12009.699757506132, 522778.0, 524401.0, 529045.0, 530144.0, 530528.0, 100455.49772251092, 102417.48791255995, 102880.48559757153, 102933.48533257286, 103416.0, 996.3822430093244, 1001.529281237817, 1019.169376957777, 1029.4543891737392, 1031.51003273446, 15838.28727707279, 17739.55651108681, 17906.194221260335, 18593.16330765146, 18792.342268020555, 42805.14389712126, 43843.34234986414, 44022.33966490441, 44248.0, 44728.0, 57811.0, 58322.708386457794, 64092.679536602016, 64475.67762161159, 65326.713565025, 8476.576171191538, 8998.820023599623, 9029.36794424384, 9057.411268267542, 9210.171084602418, 13688.589342319747, 13697.315134243048, 14185.290735463392, 14292.71414571682, 14413.927930360282, 12308.753824923273, 12614.747705046031, 12786.808197877226, 12856.421461034462, 12919.095663303478, 12171.208871423329, 12317.72122157368, 12416.813747793609, 12417.937910310391, 12656.43046062911, 12145.574904878287, 12326.07554433439, 12451.937740311603, 12510.124291299522, 12700.36498175069, 7920.960395197987, 8102.432829701865, 8751.824963500567, 8809.515476648847, 8932.821343572961, 8651.52416617092, 12590.24458532491, 12594.307313097868, 12726.872731272939, 12785.04112191608], "value": 9656.193066040827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.2206509192133, 1468.8310844252908, 1506.0361368724016, 1608.9758653620197, 1781.5635169383504, 8168.142345053773, 8519.91480085199, 8559.614817333219, 8737.694180703676, 8756.649734010647, 8454.450460720065, 8674.132586741323, 8701.086385929466, 8709.172628600289, 8714.25928796053, 2046.7032280319345, 2243.248511748558, 2309.722833260011, 2323.175272778165, 2335.3461030911285, 2349.142562964514, 2349.788519033287, 2352.023910077316, 2354.058376649337, 2359.0445869422824, 2296.9770302297015, 2300.275413244831, 2336.3691803213123, 2336.4275752440676, 2337.567550003246, 1958.7061940708866, 2006.347936920492, 2008.768991565974, 2168.6530155175174, 2222.588821068108, 2286.0512887151813, 2313.560423519526, 2317.3395582259145, 2318.7217533895873, 2322.303309007291, 8843.380963332569, 8852.159044890725, 8857.468551886908, 8859.114088591154, 8870.600822962982, 4996.200607902754, 5109.080365534202, 5112.616553758483, 5113.258577506241, 5121.615878809104, 3242.5946756655417, 3298.09302441828, 3361.8991430257133, 3366.6969972702327, 3374.4938259261307, 1058.5606973106228, 1079.96220132295, 1107.767368852542, 1107.7729065541625, 1117.1398023521842, 12408.193467424679, 12408.56570020045, 12426.813597796041, 12430.0, 12461.252324860447, 4399.64802815774, 4503.977480112579, 4514.390557274792, 4523.457185137804, 4526.932096018562, 10465.529051192714, 10468.73828154287, 10487.0, 10503.2122590806, 10515.106215971575, 5047.823326183566, 5055.140626093499, 5062.82280120194, 5064.442911279756, 5069.543741063322, 4128.504579450485, 4502.4371953505815, 4684.297355396649, 4690.718556886598, 4701.858944231679, 3936.4095385692376, 3962.821673024663, 3967.3652215645357, 3970.5433875104154, 4057.4522439470884, 1158.5944919278354, 1220.5789002794022, 1252.3362617812575, 1306.053111494159, 1319.3535167767725, 992.980140397188, 994.4033579852031, 1014.1987829614521, 1019.3527110285022, 1030.8659874216303, 6074.119252708332, 6115.724792384353, 6149.292831324366, 6156.0458128989185, 6241.313455519889, 987.3582171588381, 990.321629683669, 1014.4826138669332, 1018.9032041956002, 1019.7304356076731, 4093.7339072960162, 4150.584941505826, 4165.166966606691, 4253.3619957006695, 4280.272353699816, 10779.622713205157, 10925.836112458319, 10957.12343012557, 11058.170637202242, 11067.114630829514, 10917.181211409175, 10926.890731092588, 10941.398223097647, 10948.781024379627, 10955.178361622751, 7860.764177074697, 8176.509409435453, 8178.550179740171, 8245.257926786619, 8345.499270043816, 6139.140520327247, 6266.310705822447, 6298.338674439118, 6298.905516417349, 6336.260356203764, 10304.072633463024, 10344.32761870476, 10375.429351385445, 10537.683869483928, 10576.735581610214, 10331.121854642439, 10535.63125290611, 10678.466076695979, 10723.142148628247, 10730.356178629307, 7899.68401263943, 7936.325412340016, 8015.970363454956, 8097.433179677601, 8114.634841432032, 8581.399302048796, 8607.35444841652, 8621.051684314845, 8632.78418039554, 8666.653333866574, 7348.669309880961, 7423.146338170964, 7547.433942454448, 7562.848743025219, 7781.0, 7331.4134869209265, 7412.851742965218, 7458.925410745823, 7585.544867307979, 7724.0, 7126.928730712627, 7162.140543134858, 7210.495265331377, 7216.134063912364, 7228.566286022856, 4911.778969946433, 5057.418396884405, 5147.047796157723, 5169.0, 5210.843674689765, 5227.398849132246, 5392.083345831296, 5449.809256676156, 5516.889662206813, 5523.28197334344], "value": 4644.039642613097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.1784234227495, 315.71901008102793, 318.3426224845692, 318.4824659927618, 319.4537341146639, 5371.194320851874, 5376.489233522809, 5383.757730902109, 5387.622866399349, 5403.567714582834, 5269.710165940872, 5302.098643230651, 5308.416074231841, 5310.15037593985, 5321.2439894834615, 4012.658923991457, 4028.415879697442, 4176.540580536139, 4179.958200417987, 4187.434696316004, 4137.482814648169, 4139.0, 4154.875353739378, 4157.833686652531, 4167.166566686659, 3984.7011474139554, 4111.095558977036, 4111.951452379639, 4112.465379500661, 4143.937840932374, 4071.7149799514045, 4072.735272207297, 4095.9180816383805, 4162.875113746592, 4177.749335039907, 3675.4119340905327, 3685.4471829225563, 3685.963140368589, 3688.391415416453, 3704.7962362070075, 5153.974230128825, 5233.685978841282, 5257.7108259045735, 5257.894842103136, 5268.631195816294, 4704.106219818258, 4736.8578942631775, 4740.620750339965, 4747.7388743619085, 4776.188048031843, 5547.611667183299, 5587.8882422351735, 5595.38450770415, 5597.788873395027, 5614.578906581982, 4042.595740425934, 4048.473698419216, 4068.4304197412384, 4071.084006098634, 4083.0, 5561.138023606348, 5694.572907031989, 5734.856628584319, 5749.425057494259, 5750.166225897264, 4080.510338759368, 4090.4682391288943, 4118.546959834416, 4150.211459822624, 4168.457670661814, 4193.098483825992, 4193.7693426861815, 4205.5794420557695, 4218.2196293685765, 4218.388333691598, 4467.463904331501, 4685.0, 4686.27362758773, 4697.859064228079, 4785.49752276013, 5530.856303637655, 5549.473894678915, 5559.138333558305, 5576.581756368208, 5579.525740312038, 1394.3655636685285, 1414.519063518388, 1424.266502751084, 1426.686129051607, 1431.1895452252909, 900.2213085680839, 908.981820363589, 909.3725329522608, 910.6539514984264, 911.7128104647015, 4792.688475249098, 4805.8077676892535, 4810.4467986182035, 4911.2810516319005, 4938.8765280868265, 5050.535344749981, 5067.847964561069, 5130.974345128325, 5143.254228136974, 5188.558972487305, 4818.229083346648, 4820.9517904821205, 4847.975760121177, 5112.130937740593, 5557.888842223214, 3041.14132715247, 3055.4805683033937, 3066.2794243352796, 3068.4170007698467, 3071.585335979659, 5981.0, 6003.339632640406, 6004.279486461653, 6006.12911127884, 6045.486133678599, 5559.861003474945, 5837.591368604157, 5837.6497410155525, 5850.4788754923175, 5873.823785286449, 5931.0344827586205, 5939.693267481147, 5961.940380596226, 5994.0, 6010.459058684739, 5597.132444471114, 5650.830475085754, 5779.913301300399, 5780.624259423124, 5799.188113664006, 5712.65724056558, 5731.541476681772, 5740.13897915316, 5747.281589801275, 5757.625754325955, 5861.443162899518, 5960.433758792908, 5966.373530779206, 6002.639841609517, 6015.939840601538, 3833.3291673957506, 4031.67746580267, 4036.8990775230855, 4038.7980600970423, 4043.2317859606583, 5516.641418307797, 5638.887222255614, 5704.258446402107, 5733.913991290217, 5745.396733342939, 5593.720313984366, 5603.971980140073, 5613.691246981455, 5621.381648018796, 5638.746256418389, 5553.555715542666, 5569.972150139385, 5573.7770489179975, 5574.637648552994, 5581.469760372758, 5297.284866542967, 5513.145462453166, 5530.529904958124, 5556.138798486241, 5561.0, 5562.193481945176, 5582.023145949362, 5612.0, 5643.181738647955, 5653.321601407857, 5286.841394758163, 5554.888902221852, 5557.277553917965, 5579.609427340048, 5608.859778505407], "value": 4223.9204782406005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.8534293141373, 736.1276886889041, 768.727101878833, 784.0043145205589, 868.9391742578018, 14764.261786910653, 15932.0, 15944.760828587552, 15961.12213828239, 16049.438269660564, 15124.924375378108, 15130.092194468312, 15290.617734556614, 15314.770278445805, 16268.349266029374, 650.9772157974472, 799.0411506192563, 815.095244278853, 817.6851912013888, 818.1205204405259, 739.9963000184991, 781.601383294521, 783.8706613408809, 788.0976282156927, 790.6363072986433, 843.6541018182546, 844.7085755414403, 847.4110493207223, 847.5677404523707, 848.088305072047, 680.4556354916048, 801.0827602395283, 848.0120659431755, 848.3255811629738, 848.4866655673352, 616.1866336435861, 617.7158507086746, 618.0852338538942, 618.2086928731231, 618.3105836991767, 15972.121533315663, 15991.520254392386, 16081.437149699705, 16104.275307611186, 16105.43630972922, 14467.348969296407, 14639.780403293958, 14648.560543183616, 14716.852831471655, 14765.630859228606, 13159.60521184366, 13253.86746132536, 13310.667233319244, 13661.043726939119, 14206.289685515787, 4283.100548884738, 4331.285337919239, 4399.406080179167, 4415.889602759925, 4540.591346778772, 84609.15390846075, 85032.0, 85472.57263713641, 86174.13825861724, 86578.0, 11432.634269065276, 11626.709332266591, 11667.183297169116, 11681.299122052704, 11824.290542567473, 21517.462063448227, 21525.031373588226, 21527.67708484374, 21532.354029379145, 21533.46166345854, 8728.519931403835, 8736.432131911406, 8779.912200878038, 8823.441441261848, 8937.150970657776, 4814.711117332971, 4840.491748366441, 4957.851264462072, 4959.479254678279, 5083.085044691991, 3425.6916877481144, 3534.2048039190977, 3539.840707168132, 3544.503769472276, 3547.4324108142573, 585.3853453873415, 598.9041753319535, 604.2205554834214, 613.9877202455926, 617.478230894893, 683.5420268420171, 710.8045287545863, 711.4557363616838, 713.3472872321871, 721.8051126196003, 8258.42191046633, 8595.3553483489, 9104.499252541174, 9865.901340986642, 10064.849027264598, 636.4780879678711, 667.9613201471758, 711.7508871894795, 712.5119293284117, 713.5433322673493, 4721.834735784231, 4927.605791536668, 4939.53074457926, 4940.629452791055, 5005.299258103868, 82222.17777822145, 92942.0, 130698.34650826875, 133041.0, 133060.0, 109159.45420272848, 109182.45408772906, 109357.0, 110048.4497577507, 110137.0, 60703.392966070656, 87054.0, 92685.5365723167, 94287.0, 96181.51909240549, 8876.556172191495, 8935.955320223356, 8995.0, 9002.189802917506, 9285.396449230779, 56131.14164017123, 56151.0, 56297.155542667715, 57742.13386799285, 58930.70534647299, 75935.62032190025, 76173.61913190398, 84885.57557212174, 84896.5755171245, 85847.0, 11307.208495405243, 11389.772204556028, 11459.713507162387, 11823.881761182278, 12152.331621760888, 13053.804192936923, 13142.0, 13145.474181033034, 13235.867641323848, 13811.654708632364, 12374.876251237372, 12605.74788504243, 12630.747385052431, 12712.237265764084, 12754.48982040745, 12601.306928118674, 12699.174553653984, 12981.0, 13357.53248636293, 13376.264305463294, 12364.62906112818, 12455.564055258023, 12816.590175080548, 12945.0, 13000.674983125498, 10458.529366178387, 10670.73323166927, 10844.132469402271, 10850.728731781768, 11016.17378696585, 10674.8932510677, 10701.785964280827, 10756.872723644228, 10854.620088296871, 10883.183761217782], "value": 7594.977432517246, "unit": "score"}], "name": "dromaeo_css", "value": 7303.48411973548, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0, 109.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 119.0, 168.0, 117.0, 122.0, 150.0, 117.0, 149.0, 117.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 162.0, 162.0, 161.0, 163.0, 161.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 114.0, 76.0, 75.0, 74.0, 76.0, 100.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 85.0, 84.0, 85.0, 126.0, 84.0, 85.0, 139.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 52.0, 52.0, 51.0, 53.0, 53.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 63.0, 62.0, 63.0, 62.0, 61.0, 61.0, 66.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 73.0, 74.0, 75.0, 75.0, 74.0, 74.0, 73.0, 80.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 126.0, 120.0, 121.0, 119.0, 121.0, 124.0, 171.0, 133.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 157.0, 158.0, 156.0, 157.0, 157.0, 157.0, 159.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 64.0, 64.0, 62.0, 64.0, 63.0, 64.0, 67.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1481.1000000000001, "alertThreshold": 2.0}]} 23:21:06 INFO - Return code: 0 23:21:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:21:06 INFO - # TBPL SUCCESS # 23:21:06 INFO - Running post-action listener: _resource_record_post_action 23:21:06 INFO - ##### 23:21:06 INFO - ##### Finished run-tests step (success) 23:21:06 INFO - ##### 23:21:06 INFO - Running post-run listener: _resource_record_post_run 23:21:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 564629504; Read time: 0; Write time: 467232 23:21:06 INFO - TinderboxPrint: CPU usage
13.0% 23:21:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:21:06 INFO - TinderboxPrint: I/O write bytes / time
564,629,504 / 467,232 23:21:06 INFO - TinderboxPrint: CPU idle
8,276.6 (87.0%) 23:21:06 INFO - TinderboxPrint: CPU user
1,196.5 (12.6%) 23:21:06 INFO - TinderboxPrint: Swap in / out
0 / 0 23:21:06 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256790528; Read time: 0; Write time: 270660 23:21:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296247296; Read time: 0; Write time: 194040 23:21:07 INFO - Running post-run listener: _upload_blobber_files 23:21:07 INFO - Blob upload gear active. 23:21:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:21:07 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 23:21:07 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:21:07 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:21:07 INFO - (blobuploader) - INFO - Open directory for files ... 23:21:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:21:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:08 INFO - (blobuploader) - INFO - Done attempting. 23:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:09 INFO - (blobuploader) - INFO - Done attempting. 23:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:21:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:12 INFO - (blobuploader) - INFO - Done attempting. 23:21:12 INFO - (blobuploader) - INFO - Iteration through files over. 23:21:12 INFO - Return code: 0 23:21:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:21:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:21:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1814b1f5d7aa9d4ca955b94f409c278e7a7e780b0d0e5769a074cab62e79904c4763828770a719b263721a85029bc5ae88ef51816bfd60fa946f93c2e14102de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc069a9c0c1a5c3c34b583743fac7f3e476d6d2ad2d8d4a29bb07a3536bfb08871ebbf4baadc2a64456f17b01349329d9db5b198922b30560f83d41b6ec948f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e145802d70e68977798b1e0140d56571bdc4979f033a7b812af00f760c3f471ce2a3039309ad5da2dc8995d4ddfe567e41d756cdbcbc14725d36f11750aec7e6"} 23:21:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:21:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:21:12 INFO - Contents: 23:21:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1814b1f5d7aa9d4ca955b94f409c278e7a7e780b0d0e5769a074cab62e79904c4763828770a719b263721a85029bc5ae88ef51816bfd60fa946f93c2e14102de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc069a9c0c1a5c3c34b583743fac7f3e476d6d2ad2d8d4a29bb07a3536bfb08871ebbf4baadc2a64456f17b01349329d9db5b198922b30560f83d41b6ec948f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e145802d70e68977798b1e0140d56571bdc4979f033a7b812af00f760c3f471ce2a3039309ad5da2dc8995d4ddfe567e41d756cdbcbc14725d36f11750aec7e6"} 23:21:12 INFO - Running post-run listener: copy_logs_to_upload_dir 23:21:12 INFO - Copying logs to upload dir... 23:21:12 INFO - mkdir: /builds/slave/test/build/upload/logs 23:21:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.249356 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-07 23:21:12.661595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 23:21:12.665475) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947 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/sha512/1814b1f5d7aa9d4ca955b94f409c278e7a7e780b0d0e5769a074cab62e79904c4763828770a719b263721a85029bc5ae88ef51816bfd60fa946f93c2e14102de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc069a9c0c1a5c3c34b583743fac7f3e476d6d2ad2d8d4a29bb07a3536bfb08871ebbf4baadc2a64456f17b01349329d9db5b198922b30560f83d41b6ec948f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e145802d70e68977798b1e0140d56571bdc4979f033a7b812af00f760c3f471ce2a3039309ad5da2dc8995d4ddfe567e41d756cdbcbc14725d36f11750aec7e6"} build_url:https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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/sha512/1814b1f5d7aa9d4ca955b94f409c278e7a7e780b0d0e5769a074cab62e79904c4763828770a719b263721a85029bc5ae88ef51816bfd60fa946f93c2e14102de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc069a9c0c1a5c3c34b583743fac7f3e476d6d2ad2d8d4a29bb07a3536bfb08871ebbf4baadc2a64456f17b01349329d9db5b198922b30560f83d41b6ec948f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e145802d70e68977798b1e0140d56571bdc4979f033a7b812af00f760c3f471ce2a3039309ad5da2dc8995d4ddfe567e41d756cdbcbc14725d36f11750aec7e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 23:21:12.691655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:21:12.691948) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467957175.311690-2131265947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004790 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:21:12.774956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 23:21:12.775277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 23:21:12.775643) ========= ========= Total master_lag: 0.17 =========