builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1468408389.1 results: success (0) buildid: 20160713010620 builduid: 3c0c255ab5f942f0b8747a6bf81a3941 revision: 7054f1c4d2b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.105173) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.105645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.105930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.123793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.124093) ========= 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=6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 04:13:09-- 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% 12.6M=0.001s 2016-07-13 04:13:09 (12.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.463883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.603848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.605467) ========= 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=6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015244 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.660902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:09.661271) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7054f1c4d2b1 --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 7054f1c4d2b1 --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=6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 04:13:09,733 Setting DEBUG logging. 2016-07-13 04:13:09,733 attempt 1/10 2016-07-13 04:13:09,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7054f1c4d2b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 04:13:10,070 unpacking tar archive at: fx-team-7054f1c4d2b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:10.376787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:10.377146) ========= script_repo_revision: 7054f1c4d2b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:10.377559) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:10.377845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 04:13:10.397653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 04:13:10.397977) ========= /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=6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:10 INFO - MultiFileLogger online at 20160713 04:13:10 in /builds/slave/test 04:13:10 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 04:13:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:10 INFO - {'append_to_log': False, 04:13:10 INFO - 'base_work_dir': '/builds/slave/test', 04:13:10 INFO - 'blob_upload_branch': 'Fx-Team', 04:13:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:10 INFO - 'branch': 'Fx-Team', 04:13:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:10 INFO - 'config_files': ('talos/linux_config.py',), 04:13:10 INFO - 'default_actions': ('clobber', 04:13:10 INFO - 'read-buildbot-config', 04:13:10 INFO - 'download-and-extract', 04:13:10 INFO - 'populate-webroot', 04:13:10 INFO - 'create-virtualenv', 04:13:10 INFO - 'install', 04:13:10 INFO - 'run-tests'), 04:13:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:10 INFO - 'download_minidump_stackwalk': True, 04:13:10 INFO - 'download_symbols': 'ondemand', 04:13:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:10 INFO - 'installer_path': 'installer.exe', 04:13:10 INFO - 'log_level': 'info', 04:13:10 INFO - 'log_name': 'talos', 04:13:10 INFO - 'log_to_console': True, 04:13:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:10 INFO - 'opt_config_files': (), 04:13:10 INFO - 'pip_index': False, 04:13:10 INFO - 'sps_profile': False, 04:13:10 INFO - 'sps_profile_interval': 0, 04:13:10 INFO - 'suite': 'dromaeojs', 04:13:10 INFO - 'system_bits': '32', 04:13:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:10 INFO - 'title': 'talos-linux64-ix-023', 04:13:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:10 INFO - 'use_talos_json': True, 04:13:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:10 INFO - 'work_dir': 'build'} 04:13:10 INFO - ##### 04:13:10 INFO - ##### Running clobber step. 04:13:10 INFO - ##### 04:13:10 INFO - Running pre-action listener: _resource_record_pre_action 04:13:10 INFO - Running main action method: clobber 04:13:10 INFO - rmtree: /builds/slave/test/build 04:13:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:11 INFO - Running post-action listener: _resource_record_post_action 04:13:11 INFO - ##### 04:13:11 INFO - ##### Finished clobber step (success) 04:13:11 INFO - ##### 04:13:11 INFO - ##### 04:13:11 INFO - ##### Running read-buildbot-config step. 04:13:11 INFO - ##### 04:13:11 INFO - Running pre-action listener: _resource_record_pre_action 04:13:11 INFO - Running main action method: read_buildbot_config 04:13:11 INFO - Using buildbot properties: 04:13:11 INFO - { 04:13:11 INFO - "project": "", 04:13:11 INFO - "product": "firefox", 04:13:11 INFO - "script_repo_revision": "production", 04:13:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:13:11 INFO - "repository": "", 04:13:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:13:11 INFO - "buildid": "20160713010620", 04:13:11 INFO - "pgo_build": "True", 04:13:11 INFO - "basedir": "/builds/slave/test", 04:13:11 INFO - "buildnumber": 1322, 04:13:11 INFO - "slavename": "talos-linux64-ix-023", 04:13:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:13:11 INFO - "platform": "ubuntu64_hw", 04:13:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:13:11 INFO - "branch": "fx-team", 04:13:11 INFO - "repo_path": "integration/fx-team", 04:13:11 INFO - "revision": "7054f1c4d2b1", 04:13:11 INFO - "stage_platform": "linux64-pgo", 04:13:11 INFO - "builduid": "3c0c255ab5f942f0b8747a6bf81a3941", 04:13:11 INFO - "slavebuilddir": "test" 04:13:11 INFO - } 04:13:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:13:11 INFO - Running post-action listener: _resource_record_post_action 04:13:11 INFO - ##### 04:13:11 INFO - ##### Finished read-buildbot-config step (success) 04:13:11 INFO - ##### 04:13:11 INFO - ##### 04:13:11 INFO - ##### Running download-and-extract step. 04:13:11 INFO - ##### 04:13:11 INFO - Running pre-action listener: _resource_record_pre_action 04:13:11 INFO - Running main action method: download_and_extract 04:13:11 INFO - mkdir: /builds/slave/test/build/tests 04:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:11 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:12 INFO - Downloaded 1361 bytes. 04:13:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:12 INFO - Using the following test package requirements: 04:13:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'jsshell-linux-x86_64.zip'], 04:13:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:12 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')]} 04:13:12 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:13 INFO - Downloaded 24320264 bytes. 04:13:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:14 INFO - Return code: 0 04:13:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13: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')]} 04:13:14 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:15 INFO - Downloaded 24320264 bytes. 04:13:15 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'] 04:13:15 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 04:13:17 INFO - Return code: 0 04:13:17 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')]} 04:13:17 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:18 INFO - Downloaded 14403317 bytes. 04:13:18 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'] 04:13:18 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 04:13:18 INFO - Return code: 0 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:18 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/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 04:13:20 INFO - Downloaded 60793306 bytes. 04:13:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:20 INFO - mkdir: /builds/slave/test/properties 04:13:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:20 INFO - Contents: 04:13:20 INFO - build_url:https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:20 INFO - Running post-action listener: _resource_record_post_action 04:13:20 INFO - Running post-action listener: set_extra_try_arguments 04:13:20 INFO - ##### 04:13:20 INFO - ##### Finished download-and-extract step (success) 04:13:20 INFO - ##### 04:13:20 INFO - ##### 04:13:20 INFO - ##### Running populate-webroot step. 04:13:20 INFO - ##### 04:13:20 INFO - Running pre-action listener: _resource_record_pre_action 04:13:20 INFO - Running main action method: populate_webroot 04:13:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:20 INFO - '--tppagecycles', 04:13:20 INFO - '7'], 04:13:20 INFO - 'tests': ['tsvgm']}}, 04:13:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['damp', 'tps']}, 04:13:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'tests': ['damp', 'tps']}, 04:13:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['dromaeo_dom']}, 04:13:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['basic_compositor_video']}, 04:13:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['a11yr', 04:13:20 INFO - 'ts_paint', 04:13:20 INFO - 'tpaint', 04:13:20 INFO - 'sessionrestore', 04:13:20 INFO - 'sessionrestore_no_auto_restore', 04:13:20 INFO - 'tabpaint']}, 04:13:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:20 INFO - 'ts_paint', 04:13:20 INFO - 'tpaint', 04:13:20 INFO - 'sessionrestore', 04:13:20 INFO - 'sessionrestore_no_auto_restore', 04:13:20 INFO - 'tabpaint']}, 04:13:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:20 INFO - 'ts_paint', 04:13:20 INFO - 'tpaint', 04:13:20 INFO - 'sessionrestore', 04:13:20 INFO - 'sessionrestore_no_auto_restore', 04:13:20 INFO - 'tabpaint']}, 04:13:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:20 INFO - 'ts_paint', 04:13:20 INFO - 'tpaint', 04:13:20 INFO - 'sessionrestore', 04:13:20 INFO - 'sessionrestore_no_auto_restore', 04:13:20 INFO - 'tabpaint']}, 04:13:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['a11yr', 04:13:20 INFO - 'ts_paint', 04:13:20 INFO - 'tpaint', 04:13:20 INFO - 'sessionrestore', 04:13:20 INFO - 'sessionrestore_no_auto_restore', 04:13:20 INFO - 'tabpaint']}, 04:13:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['a11yr', 04:13:20 INFO - 'ts_paint', 04:13:20 INFO - 'tpaint', 04:13:20 INFO - 'sessionrestore', 04:13:20 INFO - 'sessionrestore_no_auto_restore', 04:13:20 INFO - 'tabpaint']}, 04:13:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['tsvgx', 04:13:20 INFO - 'tsvgr_opacity', 04:13:20 INFO - 'tart', 04:13:20 INFO - 'tscrollx', 04:13:20 INFO - 'cart']}, 04:13:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:20 INFO - 'tsvgr_opacity', 04:13:20 INFO - 'tart', 04:13:20 INFO - 'tscrollx', 04:13:20 INFO - 'cart']}, 04:13:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'talos_options': ['--disable-e10s'], 04:13:20 INFO - 'tests': ['tp5o']}, 04:13:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'tests': ['tp5o']}, 04:13:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'talos_options': ['--disable-e10s', 04:13:20 INFO - '--xperf_path', 04:13:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:20 INFO - 'tests': ['tp5n']}, 04:13:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:20 INFO - 'talos_options': ['--xperf_path', 04:13:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:20 INFO - 'tests': ['tp5n']}}, 04:13:20 INFO - 'talos.zip': {'path': '', 04:13:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:20 INFO - Running post-action listener: _resource_record_post_action 04:13:20 INFO - ##### 04:13:20 INFO - ##### Finished populate-webroot step (success) 04:13:20 INFO - ##### 04:13:20 INFO - ##### 04:13:20 INFO - ##### Running create-virtualenv step. 04:13:20 INFO - ##### 04:13:20 INFO - Running pre-action listener: _resource_record_pre_action 04:13:20 INFO - Running main action method: create_virtualenv 04:13:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:20 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 04:13:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:21 INFO - Using real prefix '/usr' 04:13:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:23 INFO - Installing pip.................done. 04:13:23 INFO - Return code: 0 04:13:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:23 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 04:13:23 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 04:13:23 INFO - Using env: {'DISPLAY': ':0', 04:13:23 INFO - 'HOME': '/home/cltbld', 04:13:23 INFO - 'LANG': 'en_US.UTF-8', 04:13:23 INFO - 'LANGUAGE': 'en_US:en', 04:13:23 INFO - 'LOGNAME': 'cltbld', 04:13:23 INFO - 'MAIL': '/var/mail/cltbld', 04:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:23 INFO - 'MOZ_NO_REMOTE': '1', 04:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:23 INFO - 'NO_EM_RESTART': '1', 04:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:23 INFO - 'PWD': '/builds/slave/test', 04:13:23 INFO - 'SHELL': '/bin/bash', 04:13:23 INFO - 'SHLVL': '1', 04:13:23 INFO - 'TERM': 'linux', 04:13:23 INFO - 'TMOUT': '86400', 04:13:23 INFO - 'USER': 'cltbld', 04:13:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:23 INFO - '_': '/tools/buildbot/bin/python'} 04:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:23 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 04:13:23 INFO - Cleaning up... 04:13:23 INFO - Return code: 0 04:13:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:23 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 04:13:23 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 04:13:23 INFO - Using env: {'DISPLAY': ':0', 04:13:23 INFO - 'HOME': '/home/cltbld', 04:13:23 INFO - 'LANG': 'en_US.UTF-8', 04:13:23 INFO - 'LANGUAGE': 'en_US:en', 04:13:23 INFO - 'LOGNAME': 'cltbld', 04:13:23 INFO - 'MAIL': '/var/mail/cltbld', 04:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:23 INFO - 'MOZ_NO_REMOTE': '1', 04:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:23 INFO - 'NO_EM_RESTART': '1', 04:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:23 INFO - 'PWD': '/builds/slave/test', 04:13:23 INFO - 'SHELL': '/bin/bash', 04:13:23 INFO - 'SHLVL': '1', 04:13:23 INFO - 'TERM': 'linux', 04:13:23 INFO - 'TMOUT': '86400', 04:13:23 INFO - 'USER': 'cltbld', 04:13:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:23 INFO - '_': '/tools/buildbot/bin/python'} 04:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:23 INFO - Downloading/unpacking psutil>=3.1.1 04:13:23 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 04:13:23 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 04:13:23 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 04:13:23 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 04:13:23 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 04:13:23 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 04:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:25 INFO - Installing collected packages: psutil 04:13:25 INFO - Running setup.py install for psutil 04:13:25 INFO - building 'psutil._psutil_linux' extension 04:13:25 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 04:13:26 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 04:13:26 INFO - building 'psutil._psutil_posix' extension 04:13:26 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 04:13:26 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 04:13:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:26 INFO - Successfully installed psutil 04:13:26 INFO - Cleaning up... 04:13:26 INFO - Return code: 0 04:13:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:26 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:26 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 04:13:26 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 04:13:26 INFO - Using env: {'DISPLAY': ':0', 04:13:26 INFO - 'HOME': '/home/cltbld', 04:13:26 INFO - 'LANG': 'en_US.UTF-8', 04:13:26 INFO - 'LANGUAGE': 'en_US:en', 04:13:26 INFO - 'LOGNAME': 'cltbld', 04:13:26 INFO - 'MAIL': '/var/mail/cltbld', 04:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:26 INFO - 'MOZ_NO_REMOTE': '1', 04:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:26 INFO - 'NO_EM_RESTART': '1', 04:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:26 INFO - 'PWD': '/builds/slave/test', 04:13:26 INFO - 'SHELL': '/bin/bash', 04:13:26 INFO - 'SHLVL': '1', 04:13:26 INFO - 'TERM': 'linux', 04:13:26 INFO - 'TMOUT': '86400', 04:13:26 INFO - 'USER': 'cltbld', 04:13:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:26 INFO - '_': '/tools/buildbot/bin/python'} 04:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:26 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 04:13:26 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 04:13:26 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 04:13:26 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 04:13:26 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 04:13:26 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 04:13:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:28 INFO - Installing collected packages: mozsystemmonitor 04:13:28 INFO - Running setup.py install for mozsystemmonitor 04:13:29 INFO - Successfully installed mozsystemmonitor 04:13:29 INFO - Cleaning up... 04:13:29 INFO - Return code: 0 04:13:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:29 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')]} 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:29 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')]} 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:29 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:29 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 04:13:29 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 04:13:29 INFO - Using env: {'DISPLAY': ':0', 04:13:29 INFO - 'HOME': '/home/cltbld', 04:13:29 INFO - 'LANG': 'en_US.UTF-8', 04:13:29 INFO - 'LANGUAGE': 'en_US:en', 04:13:29 INFO - 'LOGNAME': 'cltbld', 04:13:29 INFO - 'MAIL': '/var/mail/cltbld', 04:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:29 INFO - 'MOZ_NO_REMOTE': '1', 04:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:29 INFO - 'NO_EM_RESTART': '1', 04:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:29 INFO - 'PWD': '/builds/slave/test', 04:13:29 INFO - 'SHELL': '/bin/bash', 04:13:29 INFO - 'SHLVL': '1', 04:13:29 INFO - 'TERM': 'linux', 04:13:29 INFO - 'TMOUT': '86400', 04:13:29 INFO - 'USER': 'cltbld', 04:13:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:29 INFO - '_': '/tools/buildbot/bin/python'} 04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:30 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:32 INFO - warning: no files found matching '*.txt' 04:13:32 INFO - no previously-included directories found matching 'build' 04:13:32 INFO - no previously-included directories found matching 'dist' 04:13:32 INFO - no previously-included directories found matching '.git*' 04:13:32 INFO - Installing collected packages: jsonschema, functools32 04:13:32 INFO - Running setup.py install for functools32 04:13:32 INFO - warning: no files found matching '*.txt' 04:13:32 INFO - no previously-included directories found matching 'build' 04:13:32 INFO - no previously-included directories found matching 'dist' 04:13:32 INFO - no previously-included directories found matching '.git*' 04:13:32 INFO - Successfully installed jsonschema functools32 04:13:32 INFO - Cleaning up... 04:13:32 INFO - Return code: 0 04:13:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:32 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:32 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 04:13:32 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 04:13:32 INFO - Using env: {'DISPLAY': ':0', 04:13:32 INFO - 'HOME': '/home/cltbld', 04:13:32 INFO - 'LANG': 'en_US.UTF-8', 04:13:32 INFO - 'LANGUAGE': 'en_US:en', 04:13:32 INFO - 'LOGNAME': 'cltbld', 04:13:32 INFO - 'MAIL': '/var/mail/cltbld', 04:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:32 INFO - 'MOZ_NO_REMOTE': '1', 04:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:32 INFO - 'NO_EM_RESTART': '1', 04:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:32 INFO - 'PWD': '/builds/slave/test', 04:13:32 INFO - 'SHELL': '/bin/bash', 04:13:32 INFO - 'SHLVL': '1', 04:13:32 INFO - 'TERM': 'linux', 04:13:32 INFO - 'TMOUT': '86400', 04:13:32 INFO - 'USER': 'cltbld', 04:13:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:32 INFO - '_': '/tools/buildbot/bin/python'} 04:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:34 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 04:13:34 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 04:13:34 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 04:13:34 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 04:13:34 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 04:13:34 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 04:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:35 INFO - Downloading docopt-0.6.1.tar.gz 04:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:35 INFO - Running setup.py install for blobuploader 04:13:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:35 INFO - Running setup.py install for requests 04:13:35 INFO - Running setup.py install for docopt 04:13:35 INFO - Successfully installed blobuploader requests docopt 04:13:35 INFO - Cleaning up... 04:13:35 INFO - Return code: 0 04:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:35 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 04:13:35 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 04:13:35 INFO - Using env: {'DISPLAY': ':0', 04:13:35 INFO - 'HOME': '/home/cltbld', 04:13:35 INFO - 'LANG': 'en_US.UTF-8', 04:13:35 INFO - 'LANGUAGE': 'en_US:en', 04:13:35 INFO - 'LOGNAME': 'cltbld', 04:13:35 INFO - 'MAIL': '/var/mail/cltbld', 04:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:35 INFO - 'MOZ_NO_REMOTE': '1', 04:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:35 INFO - 'NO_EM_RESTART': '1', 04:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:35 INFO - 'PWD': '/builds/slave/test', 04:13:35 INFO - 'SHELL': '/bin/bash', 04:13:35 INFO - 'SHLVL': '1', 04:13:35 INFO - 'TERM': 'linux', 04:13:35 INFO - 'TMOUT': '86400', 04:13:35 INFO - 'USER': 'cltbld', 04:13:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:35 INFO - '_': '/tools/buildbot/bin/python'} 04:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:36 INFO - Running setup.py (path:/tmp/pip-qDGe2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:36 INFO - Running setup.py (path:/tmp/pip-6UfDkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:36 INFO - Running setup.py (path:/tmp/pip-MxdOnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:36 INFO - Running setup.py (path:/tmp/pip-EVWX1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:36 INFO - Running setup.py (path:/tmp/pip-AfoxRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:36 INFO - Running setup.py (path:/tmp/pip-nr6TZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:36 INFO - Running setup.py (path:/tmp/pip-UZ7JuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:36 INFO - Running setup.py (path:/tmp/pip-Oj1gEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:36 INFO - Running setup.py (path:/tmp/pip-iN6zNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:36 INFO - Running setup.py (path:/tmp/pip-Uth_ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:36 INFO - Running setup.py (path:/tmp/pip-78vdCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:36 INFO - Running setup.py (path:/tmp/pip-v2qCJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:36 INFO - Running setup.py (path:/tmp/pip-uaV0Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:37 INFO - Running setup.py (path:/tmp/pip-xojadn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:37 INFO - Running setup.py (path:/tmp/pip-pQQVn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:37 INFO - Running setup.py (path:/tmp/pip-DHHXTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:37 INFO - Running setup.py (path:/tmp/pip-IzVnMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:37 INFO - Running setup.py install for manifestparser 04:13:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:37 INFO - Running setup.py install for mozcrash 04:13:37 INFO - Running setup.py install for mozdebug 04:13:37 INFO - Running setup.py install for mozdevice 04:13:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:37 INFO - Running setup.py install for mozfile 04:13:37 INFO - Running setup.py install for mozhttpd 04:13:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:37 INFO - Running setup.py install for mozinfo 04:13:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozInstall 04:13:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozleak 04:13:38 INFO - Running setup.py install for mozlog 04:13:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for moznetwork 04:13:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozprocess 04:13:38 INFO - Running setup.py install for mozprofile 04:13:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozrunner 04:13:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozscreenshot 04:13:38 INFO - Running setup.py install for moztest 04:13:39 INFO - Running setup.py install for mozversion 04:13:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:39 INFO - Cleaning up... 04:13:39 INFO - Return code: 0 04:13:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:39 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 04:13:39 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 04:13:39 INFO - Using env: {'DISPLAY': ':0', 04:13:39 INFO - 'HOME': '/home/cltbld', 04:13:39 INFO - 'LANG': 'en_US.UTF-8', 04:13:39 INFO - 'LANGUAGE': 'en_US:en', 04:13:39 INFO - 'LOGNAME': 'cltbld', 04:13:39 INFO - 'MAIL': '/var/mail/cltbld', 04:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:39 INFO - 'MOZ_NO_REMOTE': '1', 04:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:39 INFO - 'NO_EM_RESTART': '1', 04:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:39 INFO - 'PWD': '/builds/slave/test', 04:13:39 INFO - 'SHELL': '/bin/bash', 04:13:39 INFO - 'SHLVL': '1', 04:13:39 INFO - 'TERM': 'linux', 04:13:39 INFO - 'TMOUT': '86400', 04:13:39 INFO - 'USER': 'cltbld', 04:13:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:39 INFO - '_': '/tools/buildbot/bin/python'} 04:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:39 INFO - Running setup.py (path:/tmp/pip-vIeF9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:39 INFO - Running setup.py (path:/tmp/pip-C_nZl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:39 INFO - Running setup.py (path:/tmp/pip-Cbi3My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:39 INFO - Running setup.py (path:/tmp/pip-mt3NbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:39 INFO - Running setup.py (path:/tmp/pip-jiD4_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:39 INFO - Running setup.py (path:/tmp/pip-MlI4kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:39 INFO - Running setup.py (path:/tmp/pip-yPrCOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:39 INFO - Running setup.py (path:/tmp/pip-w23I9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:39 INFO - Running setup.py (path:/tmp/pip-qtirkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:39 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)) 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:40 INFO - Running setup.py (path:/tmp/pip-mLVZtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:40 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)) 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:40 INFO - Running setup.py (path:/tmp/pip-V3slV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:40 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)) 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:40 INFO - Running setup.py (path:/tmp/pip-qvmliA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:40 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)) 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:40 INFO - Running setup.py (path:/tmp/pip-0FPkIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:40 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)) 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:40 INFO - Running setup.py (path:/tmp/pip-7b3gn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:40 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)) 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:40 INFO - Running setup.py (path:/tmp/pip-C1MUFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:40 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)) 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:40 INFO - Running setup.py (path:/tmp/pip-S88RSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:40 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)) 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:40 INFO - Running setup.py (path:/tmp/pip-y5BO_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:40 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)) 04:13:40 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)) 04:13:40 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)) 04:13:40 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)) 04:13:40 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)) 04:13:40 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)) 04:13:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:40 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 04:13:40 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 04:13:40 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 04:13:40 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 04:13:40 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 04:13:40 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 04:13:42 INFO - Downloading blessings-1.6.tar.gz 04:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:42 INFO - Installing collected packages: blessings 04:13:42 INFO - Running setup.py install for blessings 04:13:42 INFO - Successfully installed blessings 04:13:42 INFO - Cleaning up... 04:13:42 INFO - Return code: 0 04:13:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:42 INFO - Reading from file tmpfile_stdout 04:13:42 INFO - Current package versions: 04:13:42 INFO - argparse == 1.2.1 04:13:42 INFO - blessings == 1.6 04:13:42 INFO - blobuploader == 1.2.4 04:13:42 INFO - docopt == 0.6.1 04:13:42 INFO - functools32 == 3.2.3-2 04:13:42 INFO - jsonschema == 2.5.1 04:13:42 INFO - manifestparser == 1.1 04:13:42 INFO - mozInstall == 1.12 04:13:42 INFO - mozcrash == 0.17 04:13:42 INFO - mozdebug == 0.1 04:13:42 INFO - mozdevice == 0.48 04:13:42 INFO - mozfile == 1.2 04:13:42 INFO - mozhttpd == 0.7 04:13:42 INFO - mozinfo == 0.9 04:13:42 INFO - mozleak == 0.1 04:13:42 INFO - mozlog == 3.2 04:13:42 INFO - moznetwork == 0.27 04:13:42 INFO - mozprocess == 0.23 04:13:42 INFO - mozprofile == 0.28 04:13:42 INFO - mozrunner == 6.12 04:13:42 INFO - mozscreenshot == 0.1 04:13:42 INFO - mozsystemmonitor == 0.3 04:13:42 INFO - moztest == 0.7 04:13:42 INFO - mozversion == 1.4 04:13:42 INFO - psutil == 3.1.1 04:13:42 INFO - requests == 1.2.3 04:13:42 INFO - wsgiref == 0.1.2 04:13:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:42 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 04:13:42 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 04:13:42 INFO - Using env: {'DISPLAY': ':0', 04:13:42 INFO - 'HOME': '/home/cltbld', 04:13:42 INFO - 'LANG': 'en_US.UTF-8', 04:13:42 INFO - 'LANGUAGE': 'en_US:en', 04:13:42 INFO - 'LOGNAME': 'cltbld', 04:13:42 INFO - 'MAIL': '/var/mail/cltbld', 04:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:42 INFO - 'MOZ_NO_REMOTE': '1', 04:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:42 INFO - 'NO_EM_RESTART': '1', 04:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:42 INFO - 'PWD': '/builds/slave/test', 04:13:42 INFO - 'SHELL': '/bin/bash', 04:13:42 INFO - 'SHLVL': '1', 04:13:42 INFO - 'TERM': 'linux', 04:13:42 INFO - 'TMOUT': '86400', 04:13:42 INFO - 'USER': 'cltbld', 04:13:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:42 INFO - '_': '/tools/buildbot/bin/python'} 04:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 INFO - Cleaning up... 04:13:43 INFO - Return code: 0 04:13:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:43 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')]} 04:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:43 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')]} 04:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:43 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 0x1f37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, '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': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', '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 04:13:43 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 04:13:43 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 04:13:43 INFO - Using env: {'DISPLAY': ':0', 04:13:43 INFO - 'HOME': '/home/cltbld', 04:13:43 INFO - 'LANG': 'en_US.UTF-8', 04:13:43 INFO - 'LANGUAGE': 'en_US:en', 04:13:43 INFO - 'LOGNAME': 'cltbld', 04:13:43 INFO - 'MAIL': '/var/mail/cltbld', 04:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:43 INFO - 'MOZ_NO_REMOTE': '1', 04:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:43 INFO - 'NO_EM_RESTART': '1', 04:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:43 INFO - 'PWD': '/builds/slave/test', 04:13:43 INFO - 'SHELL': '/bin/bash', 04:13:43 INFO - 'SHLVL': '1', 04:13:43 INFO - 'TERM': 'linux', 04:13:43 INFO - 'TMOUT': '86400', 04:13:43 INFO - 'USER': 'cltbld', 04:13:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:43 INFO - '_': '/tools/buildbot/bin/python'} 04:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:43 INFO - Cleaning up... 04:13:43 INFO - Return code: 0 04:13:43 INFO - Running post-action listener: _resource_record_post_action 04:13:43 INFO - Running post-action listener: _start_resource_monitoring 04:13:43 INFO - Starting resource monitoring. 04:13:43 INFO - ##### 04:13:43 INFO - ##### Finished create-virtualenv step (success) 04:13:43 INFO - ##### 04:13:43 INFO - ##### 04:13:43 INFO - ##### Running install step. 04:13:43 INFO - ##### 04:13:43 INFO - Running pre-action listener: _resource_record_pre_action 04:13:43 INFO - Running main action method: install 04:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:43 INFO - Reading from file tmpfile_stdout 04:13:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:43 INFO - Reading from file tmpfile_stdout 04:13:43 INFO - Output received: 04:13:43 INFO - Usage: mozinstall [options] installer 04:13:43 INFO - Options: 04:13:43 INFO - -h, --help show this help message and exit 04:13:43 INFO - -d DEST, --destination=DEST 04:13:43 INFO - Directory to install application into. [default: 04:13:43 INFO - "/builds/slave/test"] 04:13:43 INFO - --app=APP Application being installed. [default: firefox] 04:13:43 INFO - mkdir: /builds/slave/test/build/application 04:13:43 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'] 04:13:43 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 04:14:00 INFO - Reading from file tmpfile_stdout 04:14:00 INFO - Output received: 04:14:00 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:00 INFO - Running post-action listener: _resource_record_post_action 04:14:00 INFO - ##### 04:14:00 INFO - ##### Finished install step (success) 04:14:00 INFO - ##### 04:14:00 INFO - ##### 04:14:00 INFO - ##### Running run-tests step. 04:14:00 INFO - ##### 04:14:00 INFO - Running pre-action listener: _resource_record_pre_action 04:14:00 INFO - Running main action method: run_tests 04:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:00 INFO - Python 2.7.3 04:14:00 INFO - Return code: 0 04:14:00 INFO - grabbing minidump binary from tooltool 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 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 0x21f63b0>, '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 0x21f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:00 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 04:14:00 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 04:14:00 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 04:14:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:00 INFO - Return code: 0 04:14:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:00 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/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:14:00 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/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 04:14:00 INFO - Using env: {'DISPLAY': ':0', 04:14:00 INFO - 'HOME': '/home/cltbld', 04:14:00 INFO - 'LANG': 'en_US.UTF-8', 04:14:00 INFO - 'LANGUAGE': 'en_US:en', 04:14:00 INFO - 'LOGNAME': 'cltbld', 04:14:00 INFO - 'MAIL': '/var/mail/cltbld', 04:14:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:00 INFO - 'MOZ_NO_REMOTE': '1', 04:14:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:00 INFO - 'NO_EM_RESTART': '1', 04:14:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:00 INFO - 'PWD': '/builds/slave/test', 04:14:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:00 INFO - 'SHELL': '/bin/bash', 04:14:00 INFO - 'SHLVL': '1', 04:14:00 INFO - 'TERM': 'linux', 04:14:00 INFO - 'TMOUT': '86400', 04:14:00 INFO - 'USER': 'cltbld', 04:14:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311', 04:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:00 INFO - '_': '/tools/buildbot/bin/python'} 04:14:00 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/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:14:01 INFO - mozversion application_buildid: 20160713010620 04:14:01 INFO - mozversion application_changeset: 7054f1c4d2b11ed3511731565a264e4521cba9b4 04:14:01 INFO - mozversion application_display_name: Nightly 04:14:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:01 INFO - mozversion application_name: Firefox 04:14:01 INFO - mozversion application_remotingname: firefox 04:14:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:14:01 INFO - mozversion application_vendor: Mozilla 04:14:01 INFO - mozversion application_version: 50.0a1 04:14:01 INFO - mozversion platform_buildid: 20160713010620 04:14:01 INFO - mozversion platform_changeset: 7054f1c4d2b11ed3511731565a264e4521cba9b4 04:14:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:14:01 INFO - mozversion platform_version: 50.0a1 04:14:01 INFO - using testdate: 1468408441 04:14:01 INFO - actual date: 1468408441 04:14:01 INFO - starting webserver on 'localhost:41081' 04:14:01 INFO - SUITE-START | Running 2 tests 04:14:01 INFO - TEST-START | dromaeo_css 04:14:01 INFO - operating with platform_type : linux_ 04:14:01 INFO - Initialising browser for dromaeo_css test... 04:14:01 INFO - TEST-INFO | started process 12368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsF1IDv/profile http://localhost:41081/getInfo.html) 04:14:05 INFO - PROCESS | 12368 | __metrics Screen width/height:1600/1200 04:14:05 INFO - PROCESS | 12368 | colorDepth:24 04:14:05 INFO - PROCESS | 12368 | Browser inner width/height: 1024/697 04:14:05 INFO - PROCESS | 12368 | __metrics 04:14:06 INFO - PROCESS | 12368 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:14:06 INFO - PROCESS | 12368 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:07 INFO - TEST-INFO | 12368: exit 0 04:14:07 INFO - Browser initialized. 04:14:07 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:07 INFO - TEST-INFO | started process 12449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsF1IDv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:18 INFO - PROCESS | 12449 | RSS: Main: 158040064 04:14:18 INFO - PROCESS | 12449 | 04:15:10 INFO - PROCESS | 12449 | 1468408510487 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] 04:17:18 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:41081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41081/tests/dromaeo/cssquery-ext.html) 04:17:19 INFO - PROCESS | 12449 | RSS: Main: 254427136 04:17:19 INFO - PROCESS | 12449 | 04:20:22 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:41081/tests/dromaeo/cssquery-ext.html (next: http://localhost:41081/tests/dromaeo/cssquery-jquery.html) 04:20:22 INFO - PROCESS | 12449 | RSS: Main: 240603136 04:20:22 INFO - PROCESS | 12449 | 04:23:24 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:41081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41081/tests/dromaeo/cssquery-mootools.html) 04:23:25 INFO - PROCESS | 12449 | RSS: Main: 246804480 04:23:25 INFO - PROCESS | 12449 | 04:26:27 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:41081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41081/tests/dromaeo/cssquery-prototype.html) 04:26:27 INFO - PROCESS | 12449 | RSS: Main: 240582656 04:26:27 INFO - PROCESS | 12449 | 04:29:30 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:41081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41081/tests/dromaeo/cssquery-yui.html) 04:29:31 INFO - PROCESS | 12449 | RSS: Main: 200773632 04:29:31 INFO - PROCESS | 12449 | 04:32:33 INFO - PROCESS | 12449 | Cycle 1(1): loaded http://localhost:41081/tests/dromaeo/cssquery-yui.html (next: http://localhost:41081/tests/dromaeo/cssquery-dojo.html) 04:32:34 INFO - PROCESS | 12449 | RSS: Main: 285622272 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | __start_tp_report 04:32:34 INFO - PROCESS | 12449 | _x_x_mozilla_page_load 04:32:34 INFO - PROCESS | 12449 | _x_x_mozilla_page_load_details 04:32:34 INFO - PROCESS | 12449 | |i|pagename|runs| 04:32:34 INFO - PROCESS | 12449 | |0;dojo.html;3061.0816754973503;3063.8468076596173;3091.6290045194573;3096.2568983443966;3105.9844700776507;5283.867903302419;5312.203169524569;5339.6262261641705;5401.135818269077;5444.455554444554;5397;5403.540699040576;5452.100403433438;5461.672299662023;5483.643563168392;4895.510448955103;4912.754362281889;5003.249512573107;5003.624728145385;5125.589952803785;5059.2158215476475;5059.392872855263;5091.363579552556;5115.923261151086;5122.769475373599;4865;4873.463918968911;4891.437484689271;4932.531409516108;4952.430470495903;4879.853604391874;4905.460399356068;4913.484084171147;4979.153543897546;4981.676191047571;4899.559039686445;4928.33467481889;4929.457759646436;4952.975235123801;4992.950070499322;5310.60170487215;5348.679079255257;5412.350517937873;5492.890142197173;5509.063459211943;5841.094630332305;5841.795537156222;5864.179014937912;5891.116332550109;5892.440218179266;5706.514946229576;5863.882722345529;5875.148103524965;5892.410758924116;5942.702864856783;5418.593605479566;5464.453554644543;5481.424450432687;5504.284443022461;5560.110382338807;6029.668368239789;6042.848928776816;6049.323881575021;6055.953259287348;6056.503474227048;5511.173324001432;5716.1997320375185;5762.020456522401;5787.971060144757;5788.652680839163;5806.274215723035;5958.761649534057;5961;5961.374055724174;5971.671558064261;5851.327097383855;5876.001079816356;5880.323762767251;5900.262467191601;5901.232839730807;5685.459881311269;5700.657960522382;5717.171010203498;5898.793542226002;5911.556633252523;4403.8458653946955;4410.558944105564;4412.646988240933;4454.10917816438;4455.4876189238;3938.7439816412416;3946.3883098119836;3956;3959;3984.7210695251056;5409.323834520685;5416.404195538487;5435.0488664483555;5470.64440811346;5545.611807173459;5885.05839065756;5904.202932604129;5910.674912879833;5917;5945.316288626863;5567.582431317667;5574.303212098488;5575.581831362664;5576.6375185613615;5577.637453565505;4887.218045112765;5031.295618613397;5068.82259120929;5086.720230387365;5093.643444958817;6091.116788065706;6092.5430592705725;6098.359672234352;6101.450869421773;6103.450689437972;5918.496927761188;5930.762769489172;5936.079907614327;5941.108833674811;5941.970290148522;5762.481376676119;6003.609765365237;6023.578349515492;6060.90908636362;6072.271327440735;5700.486956173964;5755.395683453177;5760.683162425939;5770.6249093808765;5777.017906955912;5639.210510528447;5873.530117590668;5882.5293976482635;5886.6173698709445;5886.94113058864;5670.036093863971;5726.856828579319;5731.398203188772;5768.798092066758;5775.48020678141;5701.287339082614;5713.714314284186;5718.370979192368;5719.28508936383;5737.340205876378;5554.083576210041;5653.038983372754;5694.402087780723;5726.713664316851;5727.4845263926445;5736.971315143398;5778.046622307273;5789.2763404574425;5826.359100499027;5839.445252700986;5621.747021383966;5656.123300888369;5662.716864156858;5663.688497132697;5665.773369065356 04:32:34 INFO - PROCESS | 12449 | |1;ext.html;584.8800995795863;619.7613918641324;623.940725631065;629.4680994559601;639.9392057754513;33308;36780.26439471209;43553.78223108888;43650.563494365044;43685.12629747403;45909.54090459095;46580.76709616447;46672.53327466724;46732;46793.53206467934;8940.642374305036;9086.091390860895;9091.318151138657;9096.590653420611;9100;8877.556122193897;8952.776180595505;8958.507282099481;8960.551972401387;8962.955185224066;8994.550272486382;9018.188363047324;9025.774355641095;9026.187643112118;9027;8929.285657147413;8956.238719708832;8968.641254349819;8971.05803890592;8973.820523589557;8975.147361000694;9022.14289642483;9036.186743193079;9036.231920286784;9037.367384283103;43559;43766.34350484745;43992.78003609993;44037.33943990843;44109.33835992463;3580.5524309461316;3663.036540609538;3704.7036237100965;3717.5538935327663;3765.2093060457337;32939.6706032939;33085.6691433085;33250.50124248138;33592.49611255833;34636.48045279323;4293.668962621566;4318.848840290606;4338.2191205582985;4349.471252464524;4361.760103194323;344750;344815;346248;348190;348733;60772;61456.07815882765;61466.69266653638;61480;61599.692001539705;35348.82325588407;36164.63835361613;36186.27627447489;37802.62197377991;37946.62053379431;17841.553961150814;17925.7311140333;18014.3694970678;18030.819691803175;18036.09819509019;13723.1079979801;13814;13818.101823381448;13822.37799299034;13824.308784560732;19812.90093549552;19874.205031798567;19951.900240498704;19974.60050798976;20037.899810500854;7047.577145371294;7121.323474269936;7124.46566507514;7144.142702875688;7237.384822290059;936.4287784451479;1040.9843852342221;1050.6007717067466;1121.5681962444517;1147.852147852148;33236;33435.83282083574;33609.3278134436;33664.148471833796;33672.663273366954;1097.9066779323846;1118.5078565431184;1120.3222050659233;1127.6729748373043;1215.1797536662718;17505;17765.555861103316;17772.91113544424;17830.197641105922;17863.285468581373;537651;540815;542462;544940;546103;58863.117053244234;59557.404425956054;59611.70194149001;59615.701921490116;59622.40377596255;1243.3286025546286;1333.373314542183;1368.261138984957;1395.5743498233137;1398.049326457998;33131;35099.12252193614;35236.119097022776;35285.29504402103;35625.82187089048;61008.16975490742;62506.687466562376;62543;65893;66916.330836691;299185;304145;391583;395324;398404;38999.80500097481;44674.3298850511;45037.32444013277;45442;46684;50644.49355506398;50937.745311273204;51758.223626644874;52354.21468678049;52378.738106309225;43852.12295754131;44450;44765.552344477444;44849.77575112104;44907;43461.34807977946;44159.55840441555;44469.11061778681;44854.55145448634;45214.547854521035;43383;44219.77890110529;44771.10457790891;44925.101497969205;45103.54896450994;36504.26991460209;39024.6097539021;39131;39333.80333098316;39909.2018159641;24439.26682199537;24477.51044979126;24572.385690357885;24623.891924863783;24747.62878556859 04:32:34 INFO - PROCESS | 12449 | |2;jquery.html;387.34345284742375;392.62700434587146;392.89195471245415;401.8633664554051;410.6468437144056;18096.54758631033;20073;20485.180592776273;20497.07763150658;20547.280845170422;12295.569655062074;12885.67785805353;12885.871141288584;14429.783553246709;19431.708524372145;5259.184826351912;5413.783448662069;5457.426970168135;5475.6440831345835;5478.863028424282;3923.8038098095126;4365.934510982338;7515.586642734647;7537.736179233728;7539.811504712398;7289.927100728978;7503.962480187592;7510.849783004364;7531.887021694679;7636;7343.559386436831;7574.280443357872;7596.278353556431;7638.732644357448;7641.235876412342;7310.52481588695;7319.377852882511;7342.192358840523;7353.77938661841;7358;27414.725852741616;27840.443191136063;27869.442611147664;28591.428171436455;29188.562171567442;2503.436726736488;2558.9232323030337;2595.4549544595657;2880.5247134222827;3076.9384562325963;16100.677986440323;16849.663006739796;16982.23579938906;17006.659866802718;17502.299908003664;2165.9783402165936;2168.2627906511702;2168.6855405966203;2186.5954798362354;2223.4107961390246;96615;98693;101287.49356253172;102287.97712022859;102375.48812255966;17829.726115596008;17890;17984.910075449538;18679;18818.435446936615;32214.19464513359;32659.836700816344;32833.50749738708;32877.50683739746;32942.17644558905;9789.657361992297;9946.714031971638;9951.15415189717;10258.538365773558;10678.94660526708;7956.363490920712;8081.555514446762;8252.587370631445;8253.215944485264;8285.50286982783;8964.282857371394;9097.863532047024;9112.362134650512;9230.58462369195;9335.486548239776;3256.6417694053634;3418.709409700203;3467.514547963287;3510.1224693826543;3626.4560315952817;870.3211495033884;983.2871168402994;992.8262554053156;1088.4884104470887;1105.5633024955098;19527.80472195288;20344.287949921683;20812.47968800792;21094.578108437745;21374.572508549743;1023.2376879224876;1027.7071034755209;1056.2553399853084;1077.6928575356142;1103.5916710817048;11374.715632109099;11906.107041971714;11940.820887686692;11967.40162991847;12027.27836329823;444515;459481;465354;479145;479471.4237859235;76262;88024.15867127241;88255;99184;100694.4965275169;1054.857594224785;1059.7721489879714;1062.0972173652488;1068.9946550267198;1089.1341383600056;19191.424257272305;19236.422907312804;19716.21135154578;19804.90097549503;19815.702764458834;45501.54498454973;45828.541714582425;46461;46479.53520464888;46982;60300.69849650723;60328;61155.08267376082;61594.69202653958;62789.68605156945;8172.182781722018;8766.517841518778;8796.208341249318;8869.379143459895;9000.684976025808;10430;13824.894008479096;14181.574552763434;14243.64390890236;14255.64360890986;12102.455389507317;12119;12303.200291980993;12407.565735199225;12433.440495177558;12051.51793928233;12177.756444871231;12211.938940305597;12308.815367769312;12438.564650237198;12529.248245105322;12555.686107847378;12556.309402982559;12684.11211215243;12706.936465317614;8632.266257368194;8788.51663158507;8831.293496520391;8915.37592368528;9001.144891235323;8978.281737461119;11463.197576169589;12036.879631203576;12075.27548347102;12327.50689972391 04:32:34 INFO - PROCESS | 12449 | |3;mootools.html;1457.7376072306984;1529.7093552225076;1627.5524230836518;1732.4927313237486;1806.8193180681933;8529.189726975943;9094.590743416562;9157.130072643105;9178.311626628005;9181.449113053213;7765.805854853632;7969.641366138523;7969.641366138523;8241.793955151124;8978.91021089789;2249.0778780699875;2323.8605683659034;2332.4868528923694;2335.8598484090926;2338.5206032763326;2265.66015097735;2289.3360925331635;2309.399556115414;2310.3069079276233;2312.445013196829;2010.788867168941;2261.4459457432954;2262.4570103175283;2268.1834539565743;2269.239804665439;2325.6976593042964;2365.3849999000213;2365.6924599802087;2366.1245339224424;2367.1714899785024;2211.2039665720326;2219.1899956515917;2227.175944900397;2253.301476542277;2254.28989868191;8922.286217102615;8967.103289671046;8970.237529809974;8974.102589741038;8977.775555611097;5046.798128074873;5181.870453238699;5274.129768588178;5301.072312345363;5308.124159513675;3261.5049487142355;3352.4971254311804;3417.1115509967585;3417.7607567470286;3429.8456569454434;1020.1940467031037;1059.6609085092773;1075.6826736112787;1081.7241603391165;1099.3184225780067;12625.747485050248;12629.87370126296;12632.936835315764;12652.68368290791;12697.936510317482;4578.198815207325;4602.792874320664;4730.195866702668;4788.904221915612;4805.063012712558;10604.787904241872;10617.256792024638;10633.946830265799;10654.041136297616;10670.786584268426;5270.947290527046;5312.840614781563;5321.840344789663;5322.627416080837;5332.30680011596;4797.664163508521;4882.340883980688;4895.926561101586;4913.901721965541;4955.4796746341835;3992.6007399259843;4030.0730831908827;4071.572484889044;4117.21772863161;4126.112885729583;1227.7114878003663;1236.4992178167856;1243.5212443209248;1244.5768438730875;1258.628704532165;884.6505630276005;928.7724507495707;941.223490620241;948.9145976862116;955.5461155951007;5747.971260143756;5797.710114494258;5933.406659334032;6011;6105.175801266772;437.73298288044265;451.388368760325;464.2826832543728;474.103943546697;1021.4586269277295;4137.606927341898;4252.277112890816;4266.786660667016;4272.530021697611;4288.571142885687;11037.889621103686;11405;11419.143564232716;11426.371549564854;11431.971122599007;10547.472626368652;10952.945235273774;10997.395143267197;11281.04111150545;11397;8326.583670816435;8454.070052294242;8472.703455379033;8473.576321183917;8477.74566762998;5819.359870414336;6150.753969841336;6223.3465486125115;6226.346233645402;6257.217847769029;10324.48377581133;10425;10427.582896684047;10432.634857779942;10453.425061621683;10034.849477257701;10211.336263142872;10883.693956725243;10883.96602322778;10894.618688346187;7547.245275472409;7830.647620856961;7892.565908875067;7898.052233731989;7904;8753.737387878375;8770.649174032967;8802.691905783524;8848.336374771789;8861.33539984491;7898.131205567498;7903.249191326815;7957.562334071682;7998.680052797823;8007.199280071946;7723.497972631761;7746.748945368121;7755.302022817974;7761.805954851174;7956.602169891366;7401.888971665537;7459.36595389398;7469.813254668677;7472.178060413242;7475.962620186864;4956.578690811321;4959.181735013826;4961.5534601886;5042.4705405931845;5237.973810131078;4990.101781679333;5193.818216362409;5250.65870718402;5408.648437851527;5553.6390134641115 04:32:34 INFO - PROCESS | 12449 | |4;prototype.html;313.0358495832835;317.8315492788821;326.38150704415136;330.7147610014797;335.05180339638815;5335.973320133404;5363.973180134104;5394.946050539494;5495.313085864267;5499.560035197184;5076.847694569169;5329.946700532993;5400.83797486075;5402.486763757446;5442.673439593627;4013.5183777946686;4169.9791501042455;4180.456540649711;4226.661867050629;4235.491740991085;4023.8673503043433;4092.1611069730784;4102.897427564305;4112.835486580533;4202.621764041236;4149;4163.125743593834;4176.14389050244;4178.059936514291;4204.348326009458;4176.352665336863;4183.6653067754505;4194.349875769245;4199.895002624929;4209.97895010523;3617.565892092966;3652.817359132033;3670.522832031819;3675.9448608270895;3715.4612581175847;5146.897062058775;5168.819091331823;5186.948130518685;5238.161894096965;5245.291885595434;4775.283707443911;4783.832565860178;4785.593224575915;4787.281907713871;4813.542713442217;5418.591166296791;5626.831195064114;5642.0097348405;5645.294338207724;5650.660960342392;4006.559278479365;4008.316507067039;4013.6588389986596;4026.476558047435;4034.273830710471;5836.474717275466;5849.2980842298775;5856.912146317809;5880.264966879183;5880.882382352372;4050.736702114353;4120.134771697917;4126.133511962462;4128.339465685476;4134.91730165395;3982.825066605358;4140.668746500272;4167.6874234432535;4169.353750168729;4187.016051227959;4661.394018777537;4723.173444647173;4750.786214620351;4753.623188405797;4784.617230621611;5652.406497317805;5656.179853921159;5670.688112153789;5674.716264186774;5676.8864622707315;1413.4204975959808;1421.6730152064877;1427.229296180072;1435.5621535431794;1435.8492358302437;900.1313732248411;919.0745388411268;931.7158266728577;932.4032619123766;937.2408349237139;4859.416869975626;4860.927086093711;4879.902401951941;4925.38432695913;4937.23472861707;5163.948360516347;5176.456472070454;5179.585633149339;5179.792808287626;5187.936473023021;4521.909561808746;4781.378420805273;4834.975825120852;4945.554900059012;4968.354113965233;2715.4976329378733;2749.9037533686223;2757.420941602246;2758.6275852760023;2761.406297646016;5239.292695486137;5256.78972841082;5291.312129423227;5298.92051619226;5329.813456529003;5220.477952204825;5225.399079105951;5248.580113590903;5531.668099914018;5939.940600593939;5976.252968378953;5991.161237426763;5993.61041532299;6034.637921724623;6035;5821.854453638693;5840.620359676777;5895.469407753323;5904.3210030845285;5909.586328957103;5619.831405057855;5713.571482138939;5727.599068065196;5753.424657534213;5772.7690892363835;5952.375000624872;5968.253968253968;5995.940040599713;6011.27864656244;6038.882806680778;4083.5712250214488;4148.522919864255;4163.5836416358125;4180.143070670566;4196.328587425997;5564.693941833238;5666.603337766317;5771.730219351736;5813.6221145625395;5825.737586951321;5661.235733176133;5674.375818659862;5694.259746232963;5761.164631128547;5766.769329226784;5483.530489504926;5633.943660563342;5673.801416950387;5693.345265294544;5718.485336319751;5574.358948720786;5649.406812284816;5661;5663.716814159358;5698.8290351289525;5674.914876276942;5744.281964754406;5771.307443106854;5779.364269930388;5794.739236734273;5402.918956215739;5570.080936645408;5577.972110139423;5591.9720401397735;5596.104623260258 04:32:34 INFO - PROCESS | 12449 | |5;yui.html;767.8387538616887;774.7365895595497;802.7070119406418;808.5027707959605;810.5947026486755;16182.676346473078;17108.914455427737;17114.229859656298;17123.657526849485;17151.82848171518;14513.854861451382;14520.273986300695;14894.851051489482;14904.478343257988;14927.179005154712;686.7218776395567;704.1866644026157;706.2090458686279;793.020619534874;831.8669012957928;813.3858936502961;826.7313123234943;829.0797215091274;832.76682528892;833.4832403909585;866.5970323799432;871.4422769427572;871.4901782457271;872.6204101215959;872.6204101215991;719.1442183801312;736.0504948616278;864.2135656552539;866.7139843851545;868.4008034456205;619.6406084471041;634.3941535833268;634.4797266241684;637.2353176188592;638.2245571630444;15090.622734431618;15228.46700365482;15252.161131137784;15254.847451525453;15266.313015914311;14912.478063267734;15239.466618668293;15249.542513724606;15299.923500382538;15411.53765387029;13196;13424.664383390493;13496.662583435394;13647.590572282847;13818.170909745348;4456.2201614717615;4498.145352383037;4550.817967281305;4558.977205113986;4646.512116227815;80977.59511202465;81237.59381203057;81345.18654813494;81502.59248703778;81541;11106.61126860556;11646.384790829174;11837.230580012272;11947;12181.112343527062;22695.659565106536;22743.203987860677;22764.902317582993;22770.772292276866;22778.772212277996;8846.203841654153;8890.4665720057;8972.8654070189;9128.680496182602;9260;4655.092257009918;4674.205385084544;4681.7425041622355;4759.428868535729;4875.098106850244;3434.8969530914114;3519.278547897675;3540.716742660581;3543.734219933464;3549.840257188381;608.9786857460057;621.9098230756515;701.6176183979743;743.4201322968094;745.671904362079;619.3960888134034;723.25504730127;742.3133601418666;744.0699126092385;800.5556915911725;9915.405075695482;10354.741131471623;10468.47657617116;10832.133429325635;10987.285826421257;641.1024565608093;730.5799165479871;741.5328343143892;742.8848528478095;747.5141158247183;4760;5186.377634683787;5230.6773503209615;5259.8422047338645;5460.726963651801;116391.41804290924;116890.41554792342;120408.39795800965;121267;124163;102469.48765256126;102489;103606;105679.4716026415;108447.45776271068;88863.55568222118;89228;89564.5521772387;90719.54640226888;91286.54356728306;10329.638462653771;10377.221708371751;10432.478376081317;10477.790444191225;11101.888981110085;46749.76625116853;52804.73597631987;53313;53612.73193634007;54012;78242;82774.44511097684;83499.5825020871;84650;85794.57102714447;13114.540991065267;13280.867191327963;13290.335483225606;13492.325383730971;13594.524191653245;15315.61710957235;15395.538133856002;15698.607534811721;15830.28763705613;16142.354305828105;14200.502982395567;14574.344154513285;14635.70728585401;14690.41238350454;15193.240337982836;14591.92704036473;14744.778828317798;14922.701545969237;15118.848811512184;15161.317740701916;14676.192809395585;14820.40718371253;14827.481038163613;14856.777148343;14904.552863414116;11637.592684256011;11705;11897.107716921093;12268;12294.81557776652;11435.256708313933;11738.58914937973;12154.513819447124;12185.817212741638;12234.082443816571 04:32:34 INFO - PROCESS | 12449 | __end_tp_report 04:32:34 INFO - PROCESS | 12449 | __start_cc_report 04:32:34 INFO - PROCESS | 12449 | _x_x_mozilla_cycle_collect,838 04:32:34 INFO - PROCESS | 12449 | __end_cc_report 04:32:34 INFO - PROCESS | 12449 | __startTimestamp1468409554025__endTimestamp 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | ------- Summary: start ------- 04:32:34 INFO - PROCESS | 12449 | Number of tests: 6 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | [#0] dojo.html Cycles:165 Average:5431.70 Median:5663.69 stddev:638.61 (11.3%) stddev-sans-first:612.89 04:32:34 INFO - PROCESS | 12449 | Values: 3061.1 3063.8 3091.6 3096.3 3106.0 5283.9 5312.2 5339.6 5401.1 5444.5 5397.0 5403.5 5452.1 5461.7 5483.6 4895.5 4912.8 5003.2 5003.6 5125.6 5059.2 5059.4 5091.4 5115.9 5122.8 4865.0 4873.5 4891.4 4932.5 4952.4 4879.9 4905.5 4913.5 4979.2 4981.7 4899.6 4928.3 4929.5 4953.0 4993.0 5310.6 5348.7 5412.4 5492.9 5509.1 5841.1 5841.8 5864.2 5891.1 5892.4 5706.5 5863.9 5875.1 5892.4 5942.7 5418.6 5464.5 5481.4 5504.3 5560.1 6029.7 6042.8 6049.3 6056.0 6056.5 5511.2 5716.2 5762.0 5788.0 5788.7 5806.3 5958.8 5961.0 5961.4 5971.7 5851.3 5876.0 5880.3 5900.3 5901.2 5685.5 5700.7 5717.2 5898.8 5911.6 4403.8 4410.6 4412.6 4454.1 4455.5 3938.7 3946.4 3956.0 3959.0 3984.7 5409.3 5416.4 5435.0 5470.6 5545.6 5885.1 5904.2 5910.7 5917.0 5945.3 5567.6 5574.3 5575.6 5576.6 5577.6 4887.2 5031.3 5068.8 5086.7 5093.6 6091.1 6092.5 6098.4 6101.5 6103.5 5918.5 5930.8 5936.1 5941.1 5942.0 5762.5 6003.6 6023.6 6060.9 6072.3 5700.5 5755.4 5760.7 5770.6 5777.0 5639.2 5873.5 5882.5 5886.6 5886.9 5670.0 5726.9 5731.4 5768.8 5775.5 5701.3 5713.7 5718.4 5719.3 5737.3 5554.1 5653.0 5694.4 5726.7 5727.5 5737.0 5778.0 5789.3 5826.4 5839.4 5621.7 5656.1 5662.7 5663.7 5665.8 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | [#1] ext.html Cycles:180 Average:59079.14 Median:24006.16 stddev:112738.51 (469.6%) stddev-sans-first:112969.22 04:32:34 INFO - PROCESS | 12449 | Values: 584.9 619.8 623.9 629.5 639.9 33308.0 36780.3 43553.8 43650.6 43685.1 45909.5 46580.8 46672.5 46732.0 46793.5 8940.6 9086.1 9091.3 9096.6 9100.0 8877.6 8952.8 8958.5 8960.6 8963.0 8994.6 9018.2 9025.8 9026.2 9027.0 8929.3 8956.2 8968.6 8971.1 8973.8 8975.1 9022.1 9036.2 9036.2 9037.4 43559.0 43766.3 43992.8 44037.3 44109.3 3580.6 3663.0 3704.7 3717.6 3765.2 32939.7 33085.7 33250.5 33592.5 34636.5 4293.7 4318.8 4338.2 4349.5 4361.8 344750.0 344815.0 346248.0 348190.0 348733.0 60772.0 61456.1 61466.7 61480.0 61599.7 35348.8 36164.6 36186.3 37802.6 37946.6 17841.6 17925.7 18014.4 18030.8 18036.1 13723.1 13814.0 13818.1 13822.4 13824.3 19812.9 19874.2 19951.9 19974.6 20037.9 7047.6 7121.3 7124.5 7144.1 7237.4 936.4 1041.0 1050.6 1121.6 1147.9 33236.0 33435.8 33609.3 33664.1 33672.7 1097.9 1118.5 1120.3 1127.7 1215.2 17505.0 17765.6 17772.9 17830.2 17863.3 537651.0 540815.0 542462.0 544940.0 546103.0 58863.1 59557.4 59611.7 59615.7 59622.4 1243.3 1333.4 1368.3 1395.6 1398.0 33131.0 35099.1 35236.1 35285.3 35625.8 61008.2 62506.7 62543.0 65893.0 66916.3 299185.0 304145.0 391583.0 395324.0 398404.0 38999.8 44674.3 45037.3 45442.0 46684.0 50644.5 50937.7 51758.2 52354.2 52378.7 43852.1 44450.0 44765.6 44849.8 44907.0 43461.3 44159.6 44469.1 44854.6 45214.5 43383.0 44219.8 44771.1 44925.1 45103.5 36504.3 39024.6 39131.0 39333.8 39909.2 24439.3 24477.5 24572.4 24623.9 24747.6 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | [#2] jquery.html Cycles:180 Average:30525.84 Median:16132.75 stddev:77152.87 (478.2%) stddev-sans-first:77336.12 04:32:34 INFO - PROCESS | 12449 | Values: 387.3 392.6 392.9 401.9 410.6 18096.5 20073.0 20485.2 20497.1 20547.3 12295.6 12885.7 12885.9 14429.8 19431.7 5259.2 5413.8 5457.4 5475.6 5478.9 3923.8 4365.9 7515.6 7537.7 7539.8 7289.9 7504.0 7510.8 7531.9 7636.0 7343.6 7574.3 7596.3 7638.7 7641.2 7310.5 7319.4 7342.2 7353.8 7358.0 27414.7 27840.4 27869.4 28591.4 29188.6 2503.4 2558.9 2595.5 2880.5 3076.9 16100.7 16849.7 16982.2 17006.7 17502.3 2166.0 2168.3 2168.7 2186.6 2223.4 96615.0 98693.0 101287.5 102288.0 102375.5 17829.7 17890.0 17984.9 18679.0 18818.4 32214.2 32659.8 32833.5 32877.5 32942.2 9789.7 9946.7 9951.2 10258.5 10678.9 7956.4 8081.6 8252.6 8253.2 8285.5 8964.3 9097.9 9112.4 9230.6 9335.5 3256.6 3418.7 3467.5 3510.1 3626.5 870.3 983.3 992.8 1088.5 1105.6 19527.8 20344.3 20812.5 21094.6 21374.6 1023.2 1027.7 1056.3 1077.7 1103.6 11374.7 11906.1 11940.8 11967.4 12027.3 444515.0 459481.0 465354.0 479145.0 479471.4 76262.0 88024.2 88255.0 99184.0 100694.5 1054.9 1059.8 1062.1 1069.0 1089.1 19191.4 19236.4 19716.2 19804.9 19815.7 45501.5 45828.5 46461.0 46479.5 46982.0 60300.7 60328.0 61155.1 61594.7 62789.7 8172.2 8766.5 8796.2 8869.4 9000.7 10430.0 13824.9 14181.6 14243.6 14255.6 12102.5 12119.0 12303.2 12407.6 12433.4 12051.5 12177.8 12211.9 12308.8 12438.6 12529.2 12555.7 12556.3 12684.1 12706.9 8632.3 8788.5 8831.3 8915.4 9001.1 8978.3 11463.2 12036.9 12075.3 12327.5 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | [#3] mootools.html Cycles:180 Average:5892.53 Median:2597.24 stddev:3420.51 (131.7%) stddev-sans-first:3413.87 04:32:34 INFO - PROCESS | 12449 | Values: 1457.7 1529.7 1627.6 1732.5 1806.8 8529.2 9094.6 9157.1 9178.3 9181.4 7765.8 7969.6 7969.6 8241.8 8978.9 2249.1 2323.9 2332.5 2335.9 2338.5 2265.7 2289.3 2309.4 2310.3 2312.4 2010.8 2261.4 2262.5 2268.2 2269.2 2325.7 2365.4 2365.7 2366.1 2367.2 2211.2 2219.2 2227.2 2253.3 2254.3 8922.3 8967.1 8970.2 8974.1 8977.8 5046.8 5181.9 5274.1 5301.1 5308.1 3261.5 3352.5 3417.1 3417.8 3429.8 1020.2 1059.7 1075.7 1081.7 1099.3 12625.7 12629.9 12632.9 12652.7 12697.9 4578.2 4602.8 4730.2 4788.9 4805.1 10604.8 10617.3 10633.9 10654.0 10670.8 5270.9 5312.8 5321.8 5322.6 5332.3 4797.7 4882.3 4895.9 4913.9 4955.5 3992.6 4030.1 4071.6 4117.2 4126.1 1227.7 1236.5 1243.5 1244.6 1258.6 884.7 928.8 941.2 948.9 955.5 5748.0 5797.7 5933.4 6011.0 6105.2 437.7 451.4 464.3 474.1 1021.5 4137.6 4252.3 4266.8 4272.5 4288.6 11037.9 11405.0 11419.1 11426.4 11432.0 10547.5 10952.9 10997.4 11281.0 11397.0 8326.6 8454.1 8472.7 8473.6 8477.7 5819.4 6150.8 6223.3 6226.3 6257.2 10324.5 10425.0 10427.6 10432.6 10453.4 10034.8 10211.3 10883.7 10884.0 10894.6 7547.2 7830.6 7892.6 7898.1 7904.0 8753.7 8770.6 8802.7 8848.3 8861.3 7898.1 7903.2 7957.6 7998.7 8007.2 7723.5 7746.7 7755.3 7761.8 7956.6 7401.9 7459.4 7469.8 7472.2 7476.0 4956.6 4959.2 4961.6 5042.5 5238.0 4990.1 5193.8 5250.7 5408.6 5553.6 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | [#4] prototype.html Cycles:180 Average:4665.44 Median:5231.78 stddev:1384.71 (26.5%) stddev-sans-first:1349.51 04:32:34 INFO - PROCESS | 12449 | Values: 313.0 317.8 326.4 330.7 335.1 5336.0 5364.0 5394.9 5495.3 5499.6 5076.8 5329.9 5400.8 5402.5 5442.7 4013.5 4170.0 4180.5 4226.7 4235.5 4023.9 4092.2 4102.9 4112.8 4202.6 4149.0 4163.1 4176.1 4178.1 4204.3 4176.4 4183.7 4194.3 4199.9 4210.0 3617.6 3652.8 3670.5 3675.9 3715.5 5146.9 5168.8 5186.9 5238.2 5245.3 4775.3 4783.8 4785.6 4787.3 4813.5 5418.6 5626.8 5642.0 5645.3 5650.7 4006.6 4008.3 4013.7 4026.5 4034.3 5836.5 5849.3 5856.9 5880.3 5880.9 4050.7 4120.1 4126.1 4128.3 4134.9 3982.8 4140.7 4167.7 4169.4 4187.0 4661.4 4723.2 4750.8 4753.6 4784.6 5652.4 5656.2 5670.7 5674.7 5676.9 1413.4 1421.7 1427.2 1435.6 1435.8 900.1 919.1 931.7 932.4 937.2 4859.4 4860.9 4879.9 4925.4 4937.2 5163.9 5176.5 5179.6 5179.8 5187.9 4521.9 4781.4 4835.0 4945.6 4968.4 2715.5 2749.9 2757.4 2758.6 2761.4 5239.3 5256.8 5291.3 5298.9 5329.8 5220.5 5225.4 5248.6 5531.7 5939.9 5976.3 5991.2 5993.6 6034.6 6035.0 5821.9 5840.6 5895.5 5904.3 5909.6 5619.8 5713.6 5727.6 5753.4 5772.8 5952.4 5968.3 5995.9 6011.3 6038.9 4083.6 4148.5 4163.6 4180.1 4196.3 5564.7 5666.6 5771.7 5813.6 5825.7 5661.2 5674.4 5694.3 5761.2 5766.8 5483.5 5633.9 5673.8 5693.3 5718.5 5574.4 5649.4 5661.0 5663.7 5698.8 5674.9 5744.3 5771.3 5779.4 5794.7 5402.9 5570.1 5578.0 5592.0 5596.1 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - PROCESS | 12449 | [#5] yui.html Cycles:180 Average:22028.47 Median:3530.00 stddev:31584.05 (894.7%) stddev-sans-first:31632.31 04:32:34 INFO - PROCESS | 12449 | Values: 767.8 774.7 802.7 808.5 810.6 16182.7 17108.9 17114.2 17123.7 17151.8 14513.9 14520.3 14894.9 14904.5 14927.2 686.7 704.2 706.2 793.0 831.9 813.4 826.7 829.1 832.8 833.5 866.6 871.4 871.5 872.6 872.6 719.1 736.1 864.2 866.7 868.4 619.6 634.4 634.5 637.2 638.2 15090.6 15228.5 15252.2 15254.8 15266.3 14912.5 15239.5 15249.5 15299.9 15411.5 13196.0 13424.7 13496.7 13647.6 13818.2 4456.2 4498.1 4550.8 4559.0 4646.5 80977.6 81237.6 81345.2 81502.6 81541.0 11106.6 11646.4 11837.2 11947.0 12181.1 22695.7 22743.2 22764.9 22770.8 22778.8 8846.2 8890.5 8972.9 9128.7 9260.0 4655.1 4674.2 4681.7 4759.4 4875.1 3434.9 3519.3 3540.7 3543.7 3549.8 609.0 621.9 701.6 743.4 745.7 619.4 723.3 742.3 744.1 800.6 9915.4 10354.7 10468.5 10832.1 10987.3 641.1 730.6 741.5 742.9 747.5 4760.0 5186.4 5230.7 5259.8 5460.7 116391.4 116890.4 120408.4 121267.0 124163.0 102469.5 102489.0 103606.0 105679.5 108447.5 88863.6 89228.0 89564.6 90719.5 91286.5 10329.6 10377.2 10432.5 10477.8 11101.9 46749.8 52804.7 53313.0 53612.7 54012.0 78242.0 82774.4 83499.6 84650.0 85794.6 13114.5 13280.9 13290.3 13492.3 13594.5 15315.6 15395.5 15698.6 15830.3 16142.4 14200.5 14574.3 14635.7 14690.4 15193.2 14591.9 14744.8 14922.7 15118.8 15161.3 14676.2 14820.4 14827.5 14856.8 14904.6 11637.6 11705.0 11897.1 12268.0 12294.8 11435.3 11738.6 12154.5 12185.8 12234.1 04:32:34 INFO - PROCESS | 12449 | -------- Summary: end -------- 04:32:34 INFO - PROCESS | 12449 | 04:32:34 INFO - TEST-INFO | 12449: exit 0 04:32:34 INFO - TEST-OK | dromaeo_css | took 1113622ms 04:32:34 INFO - TEST-START | kraken 04:32:34 INFO - operating with platform_type : linux_ 04:32:34 INFO - Initialising browser for kraken test... 04:32:34 INFO - TEST-INFO | started process 12641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAqi9Zp/profile http://localhost:41081/getInfo.html) 04:32:38 INFO - PROCESS | 12641 | __metrics Screen width/height:1600/1200 04:32:38 INFO - PROCESS | 12641 | colorDepth:24 04:32:38 INFO - PROCESS | 12641 | Browser inner width/height: 1024/697 04:32:38 INFO - PROCESS | 12641 | __metrics 04:32:39 INFO - PROCESS | 12641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:32:39 INFO - PROCESS | 12641 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:40 INFO - TEST-INFO | 12641: exit 0 04:32:40 INFO - Browser initialized. 04:32:40 INFO - Running cycle 1/1 for kraken test... 04:32:40 INFO - TEST-INFO | started process 12725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAqi9Zp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:52 INFO - PROCESS | 12725 | RSS: Main: 157347840 04:32:52 INFO - PROCESS | 12725 | 04:32:54 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41081/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:55 INFO - PROCESS | 12725 | RSS: Main: 215719936 04:32:55 INFO - PROCESS | 12725 | 04:32:57 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41081/tests/kraken/driver.html?testName=audio-dft) 04:32:58 INFO - PROCESS | 12725 | RSS: Main: 204120064 04:32:58 INFO - PROCESS | 12725 | 04:33:01 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41081/tests/kraken/driver.html?testName=audio-fft) 04:33:02 INFO - PROCESS | 12725 | RSS: Main: 269279232 04:33:02 INFO - PROCESS | 12725 | 04:33:04 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41081/tests/kraken/driver.html?testName=audio-oscillator) 04:33:04 INFO - PROCESS | 12725 | RSS: Main: 180498432 04:33:05 INFO - PROCESS | 12725 | 04:33:07 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:07 INFO - PROCESS | 12725 | RSS: Main: 184258560 04:33:07 INFO - PROCESS | 12725 | 04:33:10 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41081/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:11 INFO - PROCESS | 12725 | RSS: Main: 218836992 04:33:11 INFO - PROCESS | 12725 | 04:33:14 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41081/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:15 INFO - PROCESS | 12725 | RSS: Main: 220954624 04:33:15 INFO - PROCESS | 12725 | 04:33:18 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41081/tests/kraken/driver.html?testName=json-parse-financial) 04:33:18 INFO - PROCESS | 12725 | RSS: Main: 221605888 04:33:18 INFO - PROCESS | 12725 | 04:33:20 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:20 INFO - PROCESS | 12725 | RSS: Main: 209170432 04:33:20 INFO - PROCESS | 12725 | 04:33:22 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:23 INFO - PROCESS | 12725 | RSS: Main: 212430848 04:33:23 INFO - PROCESS | 12725 | 04:33:25 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:25 INFO - PROCESS | 12725 | RSS: Main: 211402752 04:33:25 INFO - PROCESS | 12725 | 04:33:28 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:29 INFO - PROCESS | 12725 | RSS: Main: 222519296 04:33:29 INFO - PROCESS | 12725 | 04:33:31 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:32 INFO - PROCESS | 12725 | RSS: Main: 224542720 04:33:32 INFO - PROCESS | 12725 | 04:33:33 INFO - PROCESS | 12725 | Cycle 1(1): loaded http://localhost:41081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41081/tests/kraken/driver.html?testName=ai-astar) 04:33:34 INFO - PROCESS | 12725 | RSS: Main: 266629120 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | __start_tp_report 04:33:34 INFO - PROCESS | 12725 | _x_x_mozilla_page_load 04:33:34 INFO - PROCESS | 12725 | _x_x_mozilla_page_load_details 04:33:34 INFO - PROCESS | 12725 | |i|pagename|runs| 04:33:34 INFO - PROCESS | 12725 | |0;ai-astar;102;112;109;109;110;111;109;109;109;110 04:33:34 INFO - PROCESS | 12725 | |1;audio-beat-detection;144;115;118;165;118;118;154;116;158;117 04:33:34 INFO - PROCESS | 12725 | |2;audio-dft;160;162;160;161;160;160;160;161;161;160 04:33:34 INFO - PROCESS | 12725 | |3;audio-fft;74;74;75;121;75;77;75;74;106;74 04:33:34 INFO - PROCESS | 12725 | |4;audio-oscillator;84;84;105;84;83;83;116;83;83;128 04:33:34 INFO - PROCESS | 12725 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;118;116 04:33:34 INFO - PROCESS | 12725 | |6;imaging-darkroom;147;146;146;146;146;146;145;146;146;146 04:33:34 INFO - PROCESS | 12725 | |7;imaging-desaturate;95;96;96;95;95;95;96;95;95;96 04:33:34 INFO - PROCESS | 12725 | |8;json-parse-financial;54;52;54;53;52;53;55;53;53;53 04:33:34 INFO - PROCESS | 12725 | |9;json-stringify-tinderbox;61;61;61;61;61;61;63;61;64;61 04:33:34 INFO - PROCESS | 12725 | |10;stanford-crypto-aes;84;79;75;75;77;75;78;75;80;79 04:33:34 INFO - PROCESS | 12725 | |11;stanford-crypto-ccm;125;122;119;118;119;119;129;119;197;136 04:33:34 INFO - PROCESS | 12725 | |12;stanford-crypto-pbkdf2;156;155;154;156;156;162;155;153;152;152 04:33:34 INFO - PROCESS | 12725 | |13;stanford-crypto-sha256-iterative;63;62;63;61;63;63;63;63;62;65 04:33:34 INFO - PROCESS | 12725 | __end_tp_report 04:33:34 INFO - PROCESS | 12725 | __start_cc_report 04:33:34 INFO - PROCESS | 12725 | _x_x_mozilla_cycle_collect,1661 04:33:34 INFO - PROCESS | 12725 | __end_cc_report 04:33:34 INFO - PROCESS | 12725 | __startTimestamp1468409614245__endTimestamp 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | ------- Summary: start ------- 04:33:34 INFO - PROCESS | 12725 | Number of tests: 14 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:2.67 (2.4%) stddev-sans-first:1.09 04:33:34 INFO - PROCESS | 12725 | Values: 102.0 112.0 109.0 109.0 110.0 111.0 109.0 109.0 109.0 110.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:131.00 stddev:20.41 (15.6%) stddev-sans-first:21.21 04:33:34 INFO - PROCESS | 12725 | Values: 144.0 115.0 118.0 165.0 118.0 118.0 154.0 116.0 158.0 117.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 04:33:34 INFO - PROCESS | 12725 | Values: 160.0 162.0 160.0 161.0 160.0 160.0 160.0 161.0 161.0 160.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.50 stddev:16.74 (22.5%) stddev-sans-first:17.47 04:33:34 INFO - PROCESS | 12725 | Values: 74.0 74.0 75.0 121.0 75.0 77.0 75.0 74.0 106.0 74.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:16.80 (20.2%) stddev-sans-first:17.48 04:33:34 INFO - PROCESS | 12725 | Values: 84.0 84.0 105.0 84.0 83.0 83.0 116.0 83.0 83.0 128.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:33:34 INFO - PROCESS | 12725 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 118.0 116.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 04:33:34 INFO - PROCESS | 12725 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:33:34 INFO - PROCESS | 12725 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 04:33:34 INFO - PROCESS | 12725 | Values: 54.0 52.0 54.0 53.0 52.0 53.0 55.0 53.0 53.0 53.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:1.08 (1.8%) stddev-sans-first:1.13 04:33:34 INFO - PROCESS | 12725 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 63.0 61.0 64.0 61.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.50 stddev:2.95 (3.8%) stddev-sans-first:2.06 04:33:34 INFO - PROCESS | 12725 | Values: 84.0 79.0 75.0 75.0 77.0 75.0 78.0 75.0 80.0 79.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:123.50 stddev:24.13 (19.5%) stddev-sans-first:25.52 04:33:34 INFO - PROCESS | 12725 | Values: 125.0 122.0 119.0 118.0 119.0 119.0 129.0 119.0 197.0 136.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.50 stddev:2.88 (1.9%) stddev-sans-first:3.04 04:33:34 INFO - PROCESS | 12725 | Values: 156.0 155.0 154.0 156.0 156.0 162.0 155.0 153.0 152.0 152.0 04:33:34 INFO - PROCESS | 12725 | 04:33:34 INFO - PROCESS | 12725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 04:33:34 INFO - PROCESS | 12725 | Values: 63.0 62.0 63.0 61.0 63.0 63.0 63.0 63.0 62.0 65.0 04:33:34 INFO - PROCESS | 12725 | -------- Summary: end -------- 04:33:34 INFO - PROCESS | 12725 | 04:33:35 INFO - TEST-INFO | 12725: exit 0 04:33:35 INFO - TEST-OK | kraken | took 60478ms 04:33:35 INFO - SUITE-END | took 1174s 04:33:35 INFO - Completed test suite (00:19:34) 04:33:35 INFO - javascript benchmark 04:33:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.0816754973503, 3063.8468076596173, 3091.6290045194573, 3096.2568983443966, 3105.9844700776507, 5283.867903302419, 5312.203169524569, 5339.6262261641705, 5401.135818269077, 5444.455554444554, 5397.0, 5403.540699040576, 5452.100403433438, 5461.672299662023, 5483.643563168392, 4895.510448955103, 4912.754362281889, 5003.249512573107, 5003.624728145385, 5125.589952803785, 5059.2158215476475, 5059.392872855263, 5091.363579552556, 5115.923261151086, 5122.769475373599, 4865.0, 4873.463918968911, 4891.437484689271, 4932.531409516108, 4952.430470495903, 4879.853604391874, 4905.460399356068, 4913.484084171147, 4979.153543897546, 4981.676191047571, 4899.559039686445, 4928.33467481889, 4929.457759646436, 4952.975235123801, 4992.950070499322, 5310.60170487215, 5348.679079255257, 5412.350517937873, 5492.890142197173, 5509.063459211943, 5841.094630332305, 5841.795537156222, 5864.179014937912, 5891.116332550109, 5892.440218179266, 5706.514946229576, 5863.882722345529, 5875.148103524965, 5892.410758924116, 5942.702864856783, 5418.593605479566, 5464.453554644543, 5481.424450432687, 5504.284443022461, 5560.110382338807, 6029.668368239789, 6042.848928776816, 6049.323881575021, 6055.953259287348, 6056.503474227048, 5511.173324001432, 5716.1997320375185, 5762.020456522401, 5787.971060144757, 5788.652680839163, 5806.274215723035, 5958.761649534057, 5961.0, 5961.374055724174, 5971.671558064261, 5851.327097383855, 5876.001079816356, 5880.323762767251, 5900.262467191601, 5901.232839730807, 5685.459881311269, 5700.657960522382, 5717.171010203498, 5898.793542226002, 5911.556633252523, 4403.8458653946955, 4410.558944105564, 4412.646988240933, 4454.10917816438, 4455.4876189238, 3938.7439816412416, 3946.3883098119836, 3956.0, 3959.0, 3984.7210695251056, 5409.323834520685, 5416.404195538487, 5435.0488664483555, 5470.64440811346, 5545.611807173459, 5885.05839065756, 5904.202932604129, 5910.674912879833, 5917.0, 5945.316288626863, 5567.582431317667, 5574.303212098488, 5575.581831362664, 5576.6375185613615, 5577.637453565505, 4887.218045112765, 5031.295618613397, 5068.82259120929, 5086.720230387365, 5093.643444958817, 6091.116788065706, 6092.5430592705725, 6098.359672234352, 6101.450869421773, 6103.450689437972, 5918.496927761188, 5930.762769489172, 5936.079907614327, 5941.108833674811, 5941.970290148522, 5762.481376676119, 6003.609765365237, 6023.578349515492, 6060.90908636362, 6072.271327440735, 5700.486956173964, 5755.395683453177, 5760.683162425939, 5770.6249093808765, 5777.017906955912, 5639.210510528447, 5873.530117590668, 5882.5293976482635, 5886.6173698709445, 5886.94113058864, 5670.036093863971, 5726.856828579319, 5731.398203188772, 5768.798092066758, 5775.48020678141, 5701.287339082614, 5713.714314284186, 5718.370979192368, 5719.28508936383, 5737.340205876378, 5554.083576210041, 5653.038983372754, 5694.402087780723, 5726.713664316851, 5727.4845263926445, 5736.971315143398, 5778.046622307273, 5789.2763404574425, 5826.359100499027, 5839.445252700986, 5621.747021383966, 5656.123300888369, 5662.716864156858, 5663.688497132697, 5665.773369065356], "value": 5386.716594834136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8800995795863, 619.7613918641324, 623.940725631065, 629.4680994559601, 639.9392057754513, 33308.0, 36780.26439471209, 43553.78223108888, 43650.563494365044, 43685.12629747403, 45909.54090459095, 46580.76709616447, 46672.53327466724, 46732.0, 46793.53206467934, 8940.642374305036, 9086.091390860895, 9091.318151138657, 9096.590653420611, 9100.0, 8877.556122193897, 8952.776180595505, 8958.507282099481, 8960.551972401387, 8962.955185224066, 8994.550272486382, 9018.188363047324, 9025.774355641095, 9026.187643112118, 9027.0, 8929.285657147413, 8956.238719708832, 8968.641254349819, 8971.05803890592, 8973.820523589557, 8975.147361000694, 9022.14289642483, 9036.186743193079, 9036.231920286784, 9037.367384283103, 43559.0, 43766.34350484745, 43992.78003609993, 44037.33943990843, 44109.33835992463, 3580.5524309461316, 3663.036540609538, 3704.7036237100965, 3717.5538935327663, 3765.2093060457337, 32939.6706032939, 33085.6691433085, 33250.50124248138, 33592.49611255833, 34636.48045279323, 4293.668962621566, 4318.848840290606, 4338.2191205582985, 4349.471252464524, 4361.760103194323, 344750.0, 344815.0, 346248.0, 348190.0, 348733.0, 60772.0, 61456.07815882765, 61466.69266653638, 61480.0, 61599.692001539705, 35348.82325588407, 36164.63835361613, 36186.27627447489, 37802.62197377991, 37946.62053379431, 17841.553961150814, 17925.7311140333, 18014.3694970678, 18030.819691803175, 18036.09819509019, 13723.1079979801, 13814.0, 13818.101823381448, 13822.37799299034, 13824.308784560732, 19812.90093549552, 19874.205031798567, 19951.900240498704, 19974.60050798976, 20037.899810500854, 7047.577145371294, 7121.323474269936, 7124.46566507514, 7144.142702875688, 7237.384822290059, 936.4287784451479, 1040.9843852342221, 1050.6007717067466, 1121.5681962444517, 1147.852147852148, 33236.0, 33435.83282083574, 33609.3278134436, 33664.148471833796, 33672.663273366954, 1097.9066779323846, 1118.5078565431184, 1120.3222050659233, 1127.6729748373043, 1215.1797536662718, 17505.0, 17765.555861103316, 17772.91113544424, 17830.197641105922, 17863.285468581373, 537651.0, 540815.0, 542462.0, 544940.0, 546103.0, 58863.117053244234, 59557.404425956054, 59611.70194149001, 59615.701921490116, 59622.40377596255, 1243.3286025546286, 1333.373314542183, 1368.261138984957, 1395.5743498233137, 1398.049326457998, 33131.0, 35099.12252193614, 35236.119097022776, 35285.29504402103, 35625.82187089048, 61008.16975490742, 62506.687466562376, 62543.0, 65893.0, 66916.330836691, 299185.0, 304145.0, 391583.0, 395324.0, 398404.0, 38999.80500097481, 44674.3298850511, 45037.32444013277, 45442.0, 46684.0, 50644.49355506398, 50937.745311273204, 51758.223626644874, 52354.21468678049, 52378.738106309225, 43852.12295754131, 44450.0, 44765.552344477444, 44849.77575112104, 44907.0, 43461.34807977946, 44159.55840441555, 44469.11061778681, 44854.55145448634, 45214.547854521035, 43383.0, 44219.77890110529, 44771.10457790891, 44925.101497969205, 45103.54896450994, 36504.26991460209, 39024.6097539021, 39131.0, 39333.80333098316, 39909.2018159641, 24439.26682199537, 24477.51044979126, 24572.385690357885, 24623.891924863783, 24747.62878556859], "value": 20631.56769600065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.34345284742375, 392.62700434587146, 392.89195471245415, 401.8633664554051, 410.6468437144056, 18096.54758631033, 20073.0, 20485.180592776273, 20497.07763150658, 20547.280845170422, 12295.569655062074, 12885.67785805353, 12885.871141288584, 14429.783553246709, 19431.708524372145, 5259.184826351912, 5413.783448662069, 5457.426970168135, 5475.6440831345835, 5478.863028424282, 3923.8038098095126, 4365.934510982338, 7515.586642734647, 7537.736179233728, 7539.811504712398, 7289.927100728978, 7503.962480187592, 7510.849783004364, 7531.887021694679, 7636.0, 7343.559386436831, 7574.280443357872, 7596.278353556431, 7638.732644357448, 7641.235876412342, 7310.52481588695, 7319.377852882511, 7342.192358840523, 7353.77938661841, 7358.0, 27414.725852741616, 27840.443191136063, 27869.442611147664, 28591.428171436455, 29188.562171567442, 2503.436726736488, 2558.9232323030337, 2595.4549544595657, 2880.5247134222827, 3076.9384562325963, 16100.677986440323, 16849.663006739796, 16982.23579938906, 17006.659866802718, 17502.299908003664, 2165.9783402165936, 2168.2627906511702, 2168.6855405966203, 2186.5954798362354, 2223.4107961390246, 96615.0, 98693.0, 101287.49356253172, 102287.97712022859, 102375.48812255966, 17829.726115596008, 17890.0, 17984.910075449538, 18679.0, 18818.435446936615, 32214.19464513359, 32659.836700816344, 32833.50749738708, 32877.50683739746, 32942.17644558905, 9789.657361992297, 9946.714031971638, 9951.15415189717, 10258.538365773558, 10678.94660526708, 7956.363490920712, 8081.555514446762, 8252.587370631445, 8253.215944485264, 8285.50286982783, 8964.282857371394, 9097.863532047024, 9112.362134650512, 9230.58462369195, 9335.486548239776, 3256.6417694053634, 3418.709409700203, 3467.514547963287, 3510.1224693826543, 3626.4560315952817, 870.3211495033884, 983.2871168402994, 992.8262554053156, 1088.4884104470887, 1105.5633024955098, 19527.80472195288, 20344.287949921683, 20812.47968800792, 21094.578108437745, 21374.572508549743, 1023.2376879224876, 1027.7071034755209, 1056.2553399853084, 1077.6928575356142, 1103.5916710817048, 11374.715632109099, 11906.107041971714, 11940.820887686692, 11967.40162991847, 12027.27836329823, 444515.0, 459481.0, 465354.0, 479145.0, 479471.4237859235, 76262.0, 88024.15867127241, 88255.0, 99184.0, 100694.4965275169, 1054.857594224785, 1059.7721489879714, 1062.0972173652488, 1068.9946550267198, 1089.1341383600056, 19191.424257272305, 19236.422907312804, 19716.21135154578, 19804.90097549503, 19815.702764458834, 45501.54498454973, 45828.541714582425, 46461.0, 46479.53520464888, 46982.0, 60300.69849650723, 60328.0, 61155.08267376082, 61594.69202653958, 62789.68605156945, 8172.182781722018, 8766.517841518778, 8796.208341249318, 8869.379143459895, 9000.684976025808, 10430.0, 13824.894008479096, 14181.574552763434, 14243.64390890236, 14255.64360890986, 12102.455389507317, 12119.0, 12303.200291980993, 12407.565735199225, 12433.440495177558, 12051.51793928233, 12177.756444871231, 12211.938940305597, 12308.815367769312, 12438.564650237198, 12529.248245105322, 12555.686107847378, 12556.309402982559, 12684.11211215243, 12706.936465317614, 8632.266257368194, 8788.51663158507, 8831.293496520391, 8915.37592368528, 9001.144891235323, 8978.281737461119, 11463.197576169589, 12036.879631203576, 12075.27548347102, 12327.50689972391], "value": 10664.746848016592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.7376072306984, 1529.7093552225076, 1627.5524230836518, 1732.4927313237486, 1806.8193180681933, 8529.189726975943, 9094.590743416562, 9157.130072643105, 9178.311626628005, 9181.449113053213, 7765.805854853632, 7969.641366138523, 7969.641366138523, 8241.793955151124, 8978.91021089789, 2249.0778780699875, 2323.8605683659034, 2332.4868528923694, 2335.8598484090926, 2338.5206032763326, 2265.66015097735, 2289.3360925331635, 2309.399556115414, 2310.3069079276233, 2312.445013196829, 2010.788867168941, 2261.4459457432954, 2262.4570103175283, 2268.1834539565743, 2269.239804665439, 2325.6976593042964, 2365.3849999000213, 2365.6924599802087, 2366.1245339224424, 2367.1714899785024, 2211.2039665720326, 2219.1899956515917, 2227.175944900397, 2253.301476542277, 2254.28989868191, 8922.286217102615, 8967.103289671046, 8970.237529809974, 8974.102589741038, 8977.775555611097, 5046.798128074873, 5181.870453238699, 5274.129768588178, 5301.072312345363, 5308.124159513675, 3261.5049487142355, 3352.4971254311804, 3417.1115509967585, 3417.7607567470286, 3429.8456569454434, 1020.1940467031037, 1059.6609085092773, 1075.6826736112787, 1081.7241603391165, 1099.3184225780067, 12625.747485050248, 12629.87370126296, 12632.936835315764, 12652.68368290791, 12697.936510317482, 4578.198815207325, 4602.792874320664, 4730.195866702668, 4788.904221915612, 4805.063012712558, 10604.787904241872, 10617.256792024638, 10633.946830265799, 10654.041136297616, 10670.786584268426, 5270.947290527046, 5312.840614781563, 5321.840344789663, 5322.627416080837, 5332.30680011596, 4797.664163508521, 4882.340883980688, 4895.926561101586, 4913.901721965541, 4955.4796746341835, 3992.6007399259843, 4030.0730831908827, 4071.572484889044, 4117.21772863161, 4126.112885729583, 1227.7114878003663, 1236.4992178167856, 1243.5212443209248, 1244.5768438730875, 1258.628704532165, 884.6505630276005, 928.7724507495707, 941.223490620241, 948.9145976862116, 955.5461155951007, 5747.971260143756, 5797.710114494258, 5933.406659334032, 6011.0, 6105.175801266772, 437.73298288044265, 451.388368760325, 464.2826832543728, 474.103943546697, 1021.4586269277295, 4137.606927341898, 4252.277112890816, 4266.786660667016, 4272.530021697611, 4288.571142885687, 11037.889621103686, 11405.0, 11419.143564232716, 11426.371549564854, 11431.971122599007, 10547.472626368652, 10952.945235273774, 10997.395143267197, 11281.04111150545, 11397.0, 8326.583670816435, 8454.070052294242, 8472.703455379033, 8473.576321183917, 8477.74566762998, 5819.359870414336, 6150.753969841336, 6223.3465486125115, 6226.346233645402, 6257.217847769029, 10324.48377581133, 10425.0, 10427.582896684047, 10432.634857779942, 10453.425061621683, 10034.849477257701, 10211.336263142872, 10883.693956725243, 10883.96602322778, 10894.618688346187, 7547.245275472409, 7830.647620856961, 7892.565908875067, 7898.052233731989, 7904.0, 8753.737387878375, 8770.649174032967, 8802.691905783524, 8848.336374771789, 8861.33539984491, 7898.131205567498, 7903.249191326815, 7957.562334071682, 7998.680052797823, 8007.199280071946, 7723.497972631761, 7746.748945368121, 7755.302022817974, 7761.805954851174, 7956.602169891366, 7401.888971665537, 7459.36595389398, 7469.813254668677, 7472.178060413242, 7475.962620186864, 4956.578690811321, 4959.181735013826, 4961.5534601886, 5042.4705405931845, 5237.973810131078, 4990.101781679333, 5193.818216362409, 5250.65870718402, 5408.648437851527, 5553.6390134641115], "value": 4619.864716484067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.0358495832835, 317.8315492788821, 326.38150704415136, 330.7147610014797, 335.05180339638815, 5335.973320133404, 5363.973180134104, 5394.946050539494, 5495.313085864267, 5499.560035197184, 5076.847694569169, 5329.946700532993, 5400.83797486075, 5402.486763757446, 5442.673439593627, 4013.5183777946686, 4169.9791501042455, 4180.456540649711, 4226.661867050629, 4235.491740991085, 4023.8673503043433, 4092.1611069730784, 4102.897427564305, 4112.835486580533, 4202.621764041236, 4149.0, 4163.125743593834, 4176.14389050244, 4178.059936514291, 4204.348326009458, 4176.352665336863, 4183.6653067754505, 4194.349875769245, 4199.895002624929, 4209.97895010523, 3617.565892092966, 3652.817359132033, 3670.522832031819, 3675.9448608270895, 3715.4612581175847, 5146.897062058775, 5168.819091331823, 5186.948130518685, 5238.161894096965, 5245.291885595434, 4775.283707443911, 4783.832565860178, 4785.593224575915, 4787.281907713871, 4813.542713442217, 5418.591166296791, 5626.831195064114, 5642.0097348405, 5645.294338207724, 5650.660960342392, 4006.559278479365, 4008.316507067039, 4013.6588389986596, 4026.476558047435, 4034.273830710471, 5836.474717275466, 5849.2980842298775, 5856.912146317809, 5880.264966879183, 5880.882382352372, 4050.736702114353, 4120.134771697917, 4126.133511962462, 4128.339465685476, 4134.91730165395, 3982.825066605358, 4140.668746500272, 4167.6874234432535, 4169.353750168729, 4187.016051227959, 4661.394018777537, 4723.173444647173, 4750.786214620351, 4753.623188405797, 4784.617230621611, 5652.406497317805, 5656.179853921159, 5670.688112153789, 5674.716264186774, 5676.8864622707315, 1413.4204975959808, 1421.6730152064877, 1427.229296180072, 1435.5621535431794, 1435.8492358302437, 900.1313732248411, 919.0745388411268, 931.7158266728577, 932.4032619123766, 937.2408349237139, 4859.416869975626, 4860.927086093711, 4879.902401951941, 4925.38432695913, 4937.23472861707, 5163.948360516347, 5176.456472070454, 5179.585633149339, 5179.792808287626, 5187.936473023021, 4521.909561808746, 4781.378420805273, 4834.975825120852, 4945.554900059012, 4968.354113965233, 2715.4976329378733, 2749.9037533686223, 2757.420941602246, 2758.6275852760023, 2761.406297646016, 5239.292695486137, 5256.78972841082, 5291.312129423227, 5298.92051619226, 5329.813456529003, 5220.477952204825, 5225.399079105951, 5248.580113590903, 5531.668099914018, 5939.940600593939, 5976.252968378953, 5991.161237426763, 5993.61041532299, 6034.637921724623, 6035.0, 5821.854453638693, 5840.620359676777, 5895.469407753323, 5904.3210030845285, 5909.586328957103, 5619.831405057855, 5713.571482138939, 5727.599068065196, 5753.424657534213, 5772.7690892363835, 5952.375000624872, 5968.253968253968, 5995.940040599713, 6011.27864656244, 6038.882806680778, 4083.5712250214488, 4148.522919864255, 4163.5836416358125, 4180.143070670566, 4196.328587425997, 5564.693941833238, 5666.603337766317, 5771.730219351736, 5813.6221145625395, 5825.737586951321, 5661.235733176133, 5674.375818659862, 5694.259746232963, 5761.164631128547, 5766.769329226784, 5483.530489504926, 5633.943660563342, 5673.801416950387, 5693.345265294544, 5718.485336319751, 5574.358948720786, 5649.406812284816, 5661.0, 5663.716814159358, 5698.8290351289525, 5674.914876276942, 5744.281964754406, 5771.307443106854, 5779.364269930388, 5794.739236734273, 5402.918956215739, 5570.080936645408, 5577.972110139423, 5591.9720401397735, 5596.104623260258], "value": 4220.822550794097, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.8387538616887, 774.7365895595497, 802.7070119406418, 808.5027707959605, 810.5947026486755, 16182.676346473078, 17108.914455427737, 17114.229859656298, 17123.657526849485, 17151.82848171518, 14513.854861451382, 14520.273986300695, 14894.851051489482, 14904.478343257988, 14927.179005154712, 686.7218776395567, 704.1866644026157, 706.2090458686279, 793.020619534874, 831.8669012957928, 813.3858936502961, 826.7313123234943, 829.0797215091274, 832.76682528892, 833.4832403909585, 866.5970323799432, 871.4422769427572, 871.4901782457271, 872.6204101215959, 872.6204101215991, 719.1442183801312, 736.0504948616278, 864.2135656552539, 866.7139843851545, 868.4008034456205, 619.6406084471041, 634.3941535833268, 634.4797266241684, 637.2353176188592, 638.2245571630444, 15090.622734431618, 15228.46700365482, 15252.161131137784, 15254.847451525453, 15266.313015914311, 14912.478063267734, 15239.466618668293, 15249.542513724606, 15299.923500382538, 15411.53765387029, 13196.0, 13424.664383390493, 13496.662583435394, 13647.590572282847, 13818.170909745348, 4456.2201614717615, 4498.145352383037, 4550.817967281305, 4558.977205113986, 4646.512116227815, 80977.59511202465, 81237.59381203057, 81345.18654813494, 81502.59248703778, 81541.0, 11106.61126860556, 11646.384790829174, 11837.230580012272, 11947.0, 12181.112343527062, 22695.659565106536, 22743.203987860677, 22764.902317582993, 22770.772292276866, 22778.772212277996, 8846.203841654153, 8890.4665720057, 8972.8654070189, 9128.680496182602, 9260.0, 4655.092257009918, 4674.205385084544, 4681.7425041622355, 4759.428868535729, 4875.098106850244, 3434.8969530914114, 3519.278547897675, 3540.716742660581, 3543.734219933464, 3549.840257188381, 608.9786857460057, 621.9098230756515, 701.6176183979743, 743.4201322968094, 745.671904362079, 619.3960888134034, 723.25504730127, 742.3133601418666, 744.0699126092385, 800.5556915911725, 9915.405075695482, 10354.741131471623, 10468.47657617116, 10832.133429325635, 10987.285826421257, 641.1024565608093, 730.5799165479871, 741.5328343143892, 742.8848528478095, 747.5141158247183, 4760.0, 5186.377634683787, 5230.6773503209615, 5259.8422047338645, 5460.726963651801, 116391.41804290924, 116890.41554792342, 120408.39795800965, 121267.0, 124163.0, 102469.48765256126, 102489.0, 103606.0, 105679.4716026415, 108447.45776271068, 88863.55568222118, 89228.0, 89564.5521772387, 90719.54640226888, 91286.54356728306, 10329.638462653771, 10377.221708371751, 10432.478376081317, 10477.790444191225, 11101.888981110085, 46749.76625116853, 52804.73597631987, 53313.0, 53612.73193634007, 54012.0, 78242.0, 82774.44511097684, 83499.5825020871, 84650.0, 85794.57102714447, 13114.540991065267, 13280.867191327963, 13290.335483225606, 13492.325383730971, 13594.524191653245, 15315.61710957235, 15395.538133856002, 15698.607534811721, 15830.28763705613, 16142.354305828105, 14200.502982395567, 14574.344154513285, 14635.70728585401, 14690.41238350454, 15193.240337982836, 14591.92704036473, 14744.778828317798, 14922.701545969237, 15118.848811512184, 15161.317740701916, 14676.192809395585, 14820.40718371253, 14827.481038163613, 14856.777148343, 14904.552863414116, 11637.592684256011, 11705.0, 11897.107716921093, 12268.0, 12294.81557776652, 11435.256708313933, 11738.58914937973, 12154.513819447124, 12185.817212741638, 12234.082443816571], "value": 7940.0449286489975, "unit": "score"}], "name": "dromaeo_css", "value": 7538.485250327482, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 109.0, 109.0, 110.0, 111.0, 109.0, 109.0, 109.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 118.0, 165.0, 118.0, 118.0, 154.0, 116.0, 158.0, 117.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 121.0, 75.0, 77.0, 75.0, 74.0, 106.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 105.0, 84.0, 83.0, 83.0, 116.0, 83.0, 83.0, 128.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 53.0, 52.0, 53.0, 55.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 64.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 75.0, 75.0, 77.0, 75.0, 78.0, 75.0, 80.0, 79.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 119.0, 118.0, 119.0, 119.0, 129.0, 119.0, 197.0, 136.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 154.0, 156.0, 156.0, 162.0, 155.0, 153.0, 152.0, 152.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 61.0, 63.0, 63.0, 63.0, 63.0, 62.0, 65.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1476.3, "alertThreshold": 2.0}]} 04:33:35 INFO - Return code: 0 04:33:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:35 INFO - # TBPL SUCCESS # 04:33:35 INFO - Running post-action listener: _resource_record_post_action 04:33:35 INFO - ##### 04:33:35 INFO - ##### Finished run-tests step (success) 04:33:35 INFO - ##### 04:33:35 INFO - Running post-run listener: _resource_record_post_run 04:33:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 61440; Write bytes: 301588480; Read time: 180; Write time: 199344 04:33:35 INFO - TinderboxPrint: CPU usage
13.0% 04:33:35 INFO - TinderboxPrint: I/O read bytes / time
61,440 / 180 04:33:35 INFO - TinderboxPrint: I/O write bytes / time
301,588,480 / 199,344 04:33:35 INFO - TinderboxPrint: CPU idle
8,276.9 (87.0%) 04:33:35 INFO - TinderboxPrint: CPU user
1,197.0 (12.6%) 04:33:35 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5263360; Read time: 0; Write time: 352 04:33:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 57344; Write bytes: 296325120; Read time: 164; Write time: 198992 04:33:36 INFO - Running post-run listener: _upload_blobber_files 04:33:36 INFO - Blob upload gear active. 04:33:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:36 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 04:33:36 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'] 04:33:36 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 04:33:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:37 INFO - (blobuploader) - INFO - Done attempting. 04:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:38 INFO - (blobuploader) - INFO - Done attempting. 04:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:41 INFO - (blobuploader) - INFO - Done attempting. 04:33:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:41 INFO - Return code: 0 04:33:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/525e58eda9568dbb4dc4e80ed05705541733a5fcead14603750f89230cc4b9c0e5f09981a2be88449cb1065900c3afadc68d2af78779285664a50495d37c2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f48757b32687ac29d37887262027f30f469379a90584638a04b43df8efed65727592aed56e2ecd434676c6bcdfce3f45d1d5d09daa26fb411226a988fa555b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/648a1f626c86c471a869d19e1e41507152eff2457eb8600352f0d1cf4f6db864448e347972d34e629b47dd7ea1236c498955c529e8909b7c74504aaefaff886d"} 04:33:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:41 INFO - Contents: 04:33:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/525e58eda9568dbb4dc4e80ed05705541733a5fcead14603750f89230cc4b9c0e5f09981a2be88449cb1065900c3afadc68d2af78779285664a50495d37c2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f48757b32687ac29d37887262027f30f469379a90584638a04b43df8efed65727592aed56e2ecd434676c6bcdfce3f45d1d5d09daa26fb411226a988fa555b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/648a1f626c86c471a869d19e1e41507152eff2457eb8600352f0d1cf4f6db864448e347972d34e629b47dd7ea1236c498955c529e8909b7c74504aaefaff886d"} 04:33:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:41 INFO - Copying logs to upload dir... 04:33:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.900059 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 04:33:41.304542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 04:33:41.308450) ========= 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=6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311 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/525e58eda9568dbb4dc4e80ed05705541733a5fcead14603750f89230cc4b9c0e5f09981a2be88449cb1065900c3afadc68d2af78779285664a50495d37c2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f48757b32687ac29d37887262027f30f469379a90584638a04b43df8efed65727592aed56e2ecd434676c6bcdfce3f45d1d5d09daa26fb411226a988fa555b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/648a1f626c86c471a869d19e1e41507152eff2457eb8600352f0d1cf4f6db864448e347972d34e629b47dd7ea1236c498955c529e8909b7c74504aaefaff886d"} build_url:https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/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/525e58eda9568dbb4dc4e80ed05705541733a5fcead14603750f89230cc4b9c0e5f09981a2be88449cb1065900c3afadc68d2af78779285664a50495d37c2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f48757b32687ac29d37887262027f30f469379a90584638a04b43df8efed65727592aed56e2ecd434676c6bcdfce3f45d1d5d09daa26fb411226a988fa555b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/648a1f626c86c471a869d19e1e41507152eff2457eb8600352f0d1cf4f6db864448e347972d34e629b47dd7ea1236c498955c529e8909b7c74504aaefaff886d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 04:33:41.333398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:33:41.333718) ========= 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=6d15e502d8e29d5d2676d664000001c3-1468408383.707557-1421723311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:33:41.415781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 04:33:41.416110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 04:33:41.416393) ========= ========= Total master_lag: 0.17 =========