builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1467870045.41 results: success (0) buildid: 20160706212522 builduid: 0f25b8287bd9468183da64871ecd0943 revision: 9beedb6cbef90bfe3e2b691a17c5c616c7e65b18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:45.411240) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:45.411728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-07-06 22:40:45.412037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-07-06 22:40:48.364494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:48.364783) ========= 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-1467869532.633553-1140972771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 22:40:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-06 22:40:49 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:48.554069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:48.554345) ========= 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-1467869532.633553-1140972771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021062 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:48.612931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:40:48.613243) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9beedb6cbef90bfe3e2b691a17c5c616c7e65b18 --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 9beedb6cbef90bfe3e2b691a17c5c616c7e65b18 --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-1467869532.633553-1140972771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 22:40:49,139 truncating revision to first 12 chars 2016-07-06 22:40:49,139 Setting DEBUG logging. 2016-07-06 22:40:49,139 attempt 1/10 2016-07-06 22:40:49,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9beedb6cbef9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 22:40:49,901 unpacking tar archive at: fx-team-9beedb6cbef9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.184559 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:40:49.812069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:49.812368) ========= script_repo_revision: 9beedb6cbef90bfe3e2b691a17c5c616c7e65b18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:49.812760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:49.813024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:40:49.823865) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-06 22:40:49.824148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:40:50 INFO - MultiFileLogger online at 20160706 22:40:50 in /builds/slave/test 22:40:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:40:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:40:50 INFO - {'append_to_log': False, 22:40:50 INFO - 'base_work_dir': '/builds/slave/test', 22:40:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:40:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:40:50 INFO - 'branch': 'Fx-Team-Non-PGO', 22:40:50 INFO - 'buildbot_json_path': 'buildprops.json', 22:40:50 INFO - 'config_files': ('talos/linux_config.py',), 22:40:50 INFO - 'default_actions': ('clobber', 22:40:50 INFO - 'read-buildbot-config', 22:40:50 INFO - 'download-and-extract', 22:40:50 INFO - 'populate-webroot', 22:40:50 INFO - 'create-virtualenv', 22:40:50 INFO - 'install', 22:40:50 INFO - 'run-tests'), 22:40:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:40:50 INFO - 'download_minidump_stackwalk': True, 22:40:50 INFO - 'download_symbols': 'ondemand', 22:40:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:40:50 INFO - 'tooltool.py': '/tools/tooltool.py', 22:40:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:40:50 INFO - '/tools/misc-python/virtualenv.py')}, 22:40:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:40:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:40:50 INFO - 'installer_path': 'installer.exe', 22:40:50 INFO - 'log_level': 'info', 22:40:50 INFO - 'log_name': 'talos', 22:40:50 INFO - 'log_to_console': True, 22:40:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:40:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:40:50 INFO - 'opt_config_files': (), 22:40:50 INFO - 'pip_index': False, 22:40:50 INFO - 'sps_profile': False, 22:40:50 INFO - 'sps_profile_interval': 0, 22:40:50 INFO - 'suite': 'dromaeojs', 22:40:50 INFO - 'system_bits': '32', 22:40:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:40:50 INFO - 'title': 'talos-linux64-ix-023', 22:40:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:40:50 INFO - 'use_talos_json': True, 22:40:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:40:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:40:50 INFO - 'work_dir': 'build'} 22:40:50 INFO - ##### 22:40:50 INFO - ##### Running clobber step. 22:40:50 INFO - ##### 22:40:50 INFO - Running pre-action listener: _resource_record_pre_action 22:40:50 INFO - Running main action method: clobber 22:40:50 INFO - rmtree: /builds/slave/test/build 22:40:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:40:51 INFO - Running post-action listener: _resource_record_post_action 22:40:51 INFO - ##### 22:40:51 INFO - ##### Finished clobber step (success) 22:40:51 INFO - ##### 22:40:51 INFO - ##### 22:40:51 INFO - ##### Running read-buildbot-config step. 22:40:51 INFO - ##### 22:40:51 INFO - Running pre-action listener: _resource_record_pre_action 22:40:51 INFO - Running main action method: read_buildbot_config 22:40:51 INFO - Using buildbot properties: 22:40:51 INFO - { 22:40:51 INFO - "project": "", 22:40:51 INFO - "product": "firefox", 22:40:51 INFO - "script_repo_revision": "production", 22:40:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:40:51 INFO - "repository": "", 22:40:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:40:51 INFO - "buildid": "20160706212522", 22:40:51 INFO - "pgo_build": "False", 22:40:51 INFO - "basedir": "/builds/slave/test", 22:40:51 INFO - "buildnumber": 3140, 22:40:51 INFO - "slavename": "talos-linux64-ix-023", 22:40:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:40:51 INFO - "platform": "ubuntu64_hw", 22:40:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:40:51 INFO - "branch": "fx-team", 22:40:51 INFO - "repo_path": "integration/fx-team", 22:40:51 INFO - "revision": "9beedb6cbef90bfe3e2b691a17c5c616c7e65b18", 22:40:51 INFO - "stage_platform": "linux64", 22:40:51 INFO - "builduid": "0f25b8287bd9468183da64871ecd0943", 22:40:51 INFO - "slavebuilddir": "test" 22:40:51 INFO - } 22:40:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:40:51 INFO - Running post-action listener: _resource_record_post_action 22:40:51 INFO - ##### 22:40:51 INFO - ##### Finished read-buildbot-config step (success) 22:40:51 INFO - ##### 22:40:51 INFO - ##### 22:40:51 INFO - ##### Running download-and-extract step. 22:40:51 INFO - ##### 22:40:51 INFO - Running pre-action listener: _resource_record_pre_action 22:40:51 INFO - Running main action method: download_and_extract 22:40:51 INFO - mkdir: /builds/slave/test/build/tests 22:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:51 INFO - https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:40:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:40:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:40:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:40:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:40:55 INFO - Downloaded 1361 bytes. 22:40:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:40:55 INFO - Using the following test package requirements: 22:40:55 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:40:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:40:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:40:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'jsshell-linux-x86_64.zip'], 22:40:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:40:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:40:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:40:55 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:40:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:40:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:40:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:55 INFO - https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:03 INFO - Downloaded 22733087 bytes. 22:41:03 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'] 22:41:03 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 22:41:04 INFO - Return code: 0 22:41:04 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 22:41:04 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')]} 22:41:04 INFO - https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:41:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:41:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:05 INFO - Downloaded 22733087 bytes. 22:41:05 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'] 22:41:05 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 22:41:07 INFO - Return code: 0 22:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:07 INFO - https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:41:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:08 INFO - Downloaded 14403333 bytes. 22:41:08 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'] 22:41:08 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 22:41:09 INFO - Return code: 0 22:41:09 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')]} 22:41:09 INFO - https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:41:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:41:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:41:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:11 INFO - Downloaded 56586188 bytes. 22:41:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:41:11 INFO - mkdir: /builds/slave/test/properties 22:41:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:41:11 INFO - Writing to file /builds/slave/test/properties/build_url 22:41:11 INFO - Contents: 22:41:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:41:12 INFO - Running post-action listener: _resource_record_post_action 22:41:12 INFO - Running post-action listener: set_extra_try_arguments 22:41:12 INFO - ##### 22:41:12 INFO - ##### Finished download-and-extract step (success) 22:41:12 INFO - ##### 22:41:12 INFO - ##### 22:41:12 INFO - ##### Running populate-webroot step. 22:41:12 INFO - ##### 22:41:12 INFO - Running pre-action listener: _resource_record_pre_action 22:41:12 INFO - Running main action method: populate_webroot 22:41:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:12 INFO - '--tppagecycles', 22:41:12 INFO - '7'], 22:41:12 INFO - 'tests': ['tsvgm']}}, 22:41:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:41:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:41:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['damp', 'tps']}, 22:41:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'tests': ['damp', 'tps']}, 22:41:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['dromaeo_dom']}, 22:41:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:41:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['basic_compositor_video']}, 22:41:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:41:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['a11yr', 22:41:12 INFO - 'ts_paint', 22:41:12 INFO - 'tpaint', 22:41:12 INFO - 'sessionrestore', 22:41:12 INFO - 'sessionrestore_no_auto_restore', 22:41:12 INFO - 'tabpaint']}, 22:41:12 INFO - 'other-e10s': {'tests': ['a11yr', 22:41:12 INFO - 'ts_paint', 22:41:12 INFO - 'tpaint', 22:41:12 INFO - 'sessionrestore', 22:41:12 INFO - 'sessionrestore_no_auto_restore', 22:41:12 INFO - 'tabpaint']}, 22:41:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:41:12 INFO - 'ts_paint', 22:41:12 INFO - 'tpaint', 22:41:12 INFO - 'sessionrestore', 22:41:12 INFO - 'sessionrestore_no_auto_restore', 22:41:12 INFO - 'tabpaint']}, 22:41:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:41:12 INFO - 'ts_paint', 22:41:12 INFO - 'tpaint', 22:41:12 INFO - 'sessionrestore', 22:41:12 INFO - 'sessionrestore_no_auto_restore', 22:41:12 INFO - 'tabpaint']}, 22:41:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['a11yr', 22:41:12 INFO - 'ts_paint', 22:41:12 INFO - 'tpaint', 22:41:12 INFO - 'sessionrestore', 22:41:12 INFO - 'sessionrestore_no_auto_restore', 22:41:12 INFO - 'tabpaint']}, 22:41:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['a11yr', 22:41:12 INFO - 'ts_paint', 22:41:12 INFO - 'tpaint', 22:41:12 INFO - 'sessionrestore', 22:41:12 INFO - 'sessionrestore_no_auto_restore', 22:41:12 INFO - 'tabpaint']}, 22:41:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['tsvgx', 22:41:12 INFO - 'tsvgr_opacity', 22:41:12 INFO - 'tart', 22:41:12 INFO - 'tscrollx', 22:41:12 INFO - 'cart']}, 22:41:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:41:12 INFO - 'tsvgr_opacity', 22:41:12 INFO - 'tart', 22:41:12 INFO - 'tscrollx', 22:41:12 INFO - 'cart']}, 22:41:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'talos_options': ['--disable-e10s'], 22:41:12 INFO - 'tests': ['tp5o']}, 22:41:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'tests': ['tp5o']}, 22:41:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'talos_options': ['--disable-e10s', 22:41:12 INFO - '--xperf_path', 22:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:12 INFO - 'tests': ['tp5n']}, 22:41:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:12 INFO - 'talos_options': ['--xperf_path', 22:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:12 INFO - 'tests': ['tp5n']}}, 22:41:12 INFO - 'talos.zip': {'path': '', 22:41:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:12 INFO - Running post-action listener: _resource_record_post_action 22:41:12 INFO - ##### 22:41:12 INFO - ##### Finished populate-webroot step (success) 22:41:12 INFO - ##### 22:41:12 INFO - ##### 22:41:12 INFO - ##### Running create-virtualenv step. 22:41:12 INFO - ##### 22:41:12 INFO - Running pre-action listener: _resource_record_pre_action 22:41:12 INFO - Running main action method: create_virtualenv 22:41:12 INFO - Creating virtualenv /builds/slave/test/build/venv 22:41:12 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 22:41:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:41:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:12 INFO - Using real prefix '/usr' 22:41:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:41:13 INFO - Installing distribute.............................................................................................................................................................................................done. 22:41:15 INFO - Installing pip.................done. 22:41:15 INFO - Return code: 0 22:41:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:41:15 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')]} 22:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:15 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')]} 22:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:15 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:15 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 22:41:15 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 22:41:15 INFO - Using env: {'DISPLAY': ':0', 22:41:15 INFO - 'HOME': '/home/cltbld', 22:41:15 INFO - 'LANG': 'en_US.UTF-8', 22:41:15 INFO - 'LANGUAGE': 'en_US:en', 22:41:15 INFO - 'LOGNAME': 'cltbld', 22:41:15 INFO - 'MAIL': '/var/mail/cltbld', 22:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:15 INFO - 'MOZ_NO_REMOTE': '1', 22:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:15 INFO - 'NO_EM_RESTART': '1', 22:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:15 INFO - 'PWD': '/builds/slave/test', 22:41:15 INFO - 'SHELL': '/bin/bash', 22:41:15 INFO - 'SHLVL': '1', 22:41:15 INFO - 'TERM': 'linux', 22:41:15 INFO - 'TMOUT': '86400', 22:41:15 INFO - 'USER': 'cltbld', 22:41:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:15 INFO - '_': '/tools/buildbot/bin/python'} 22:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:15 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 22:41:15 INFO - Cleaning up... 22:41:15 INFO - Return code: 0 22:41:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:41:15 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')]} 22:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:15 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')]} 22:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:15 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:15 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 22:41:15 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 22:41:15 INFO - Using env: {'DISPLAY': ':0', 22:41:15 INFO - 'HOME': '/home/cltbld', 22:41:15 INFO - 'LANG': 'en_US.UTF-8', 22:41:15 INFO - 'LANGUAGE': 'en_US:en', 22:41:15 INFO - 'LOGNAME': 'cltbld', 22:41:15 INFO - 'MAIL': '/var/mail/cltbld', 22:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:15 INFO - 'MOZ_NO_REMOTE': '1', 22:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:15 INFO - 'NO_EM_RESTART': '1', 22:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:15 INFO - 'PWD': '/builds/slave/test', 22:41:15 INFO - 'SHELL': '/bin/bash', 22:41:15 INFO - 'SHLVL': '1', 22:41:15 INFO - 'TERM': 'linux', 22:41:15 INFO - 'TMOUT': '86400', 22:41:15 INFO - 'USER': 'cltbld', 22:41:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:15 INFO - '_': '/tools/buildbot/bin/python'} 22:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:15 INFO - Downloading/unpacking psutil>=3.1.1 22:41:15 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 22:41:15 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 22:41:15 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 22:41:15 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 22:41:15 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 22:41:15 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 22:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:17 INFO - Installing collected packages: psutil 22:41:17 INFO - Running setup.py install for psutil 22:41:17 INFO - building 'psutil._psutil_linux' extension 22:41:17 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 22:41:17 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 22:41:17 INFO - building 'psutil._psutil_posix' extension 22:41:17 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 22:41:17 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 22:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:17 INFO - Successfully installed psutil 22:41:17 INFO - Cleaning up... 22:41:17 INFO - Return code: 0 22:41:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:17 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:17 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 22:41:17 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 22:41:17 INFO - Using env: {'DISPLAY': ':0', 22:41:17 INFO - 'HOME': '/home/cltbld', 22:41:17 INFO - 'LANG': 'en_US.UTF-8', 22:41:17 INFO - 'LANGUAGE': 'en_US:en', 22:41:17 INFO - 'LOGNAME': 'cltbld', 22:41:17 INFO - 'MAIL': '/var/mail/cltbld', 22:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:17 INFO - 'MOZ_NO_REMOTE': '1', 22:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:17 INFO - 'NO_EM_RESTART': '1', 22:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:17 INFO - 'PWD': '/builds/slave/test', 22:41:17 INFO - 'SHELL': '/bin/bash', 22:41:17 INFO - 'SHLVL': '1', 22:41:17 INFO - 'TERM': 'linux', 22:41:17 INFO - 'TMOUT': '86400', 22:41:17 INFO - 'USER': 'cltbld', 22:41:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:17 INFO - '_': '/tools/buildbot/bin/python'} 22:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:41:18 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 22:41:18 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 22:41:18 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 22:41:18 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 22:41:18 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 22:41:18 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 22:41:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:41:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:41:20 INFO - Installing collected packages: mozsystemmonitor 22:41:20 INFO - Running setup.py install for mozsystemmonitor 22:41:20 INFO - Successfully installed mozsystemmonitor 22:41:20 INFO - Cleaning up... 22:41:20 INFO - Return code: 0 22:41:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:20 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:20 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 22:41:20 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 22:41:20 INFO - Using env: {'DISPLAY': ':0', 22:41:20 INFO - 'HOME': '/home/cltbld', 22:41:20 INFO - 'LANG': 'en_US.UTF-8', 22:41:20 INFO - 'LANGUAGE': 'en_US:en', 22:41:20 INFO - 'LOGNAME': 'cltbld', 22:41:20 INFO - 'MAIL': '/var/mail/cltbld', 22:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:20 INFO - 'MOZ_NO_REMOTE': '1', 22:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:20 INFO - 'NO_EM_RESTART': '1', 22:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:20 INFO - 'PWD': '/builds/slave/test', 22:41:20 INFO - 'SHELL': '/bin/bash', 22:41:20 INFO - 'SHLVL': '1', 22:41:20 INFO - 'TERM': 'linux', 22:41:20 INFO - 'TMOUT': '86400', 22:41:20 INFO - 'USER': 'cltbld', 22:41:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:20 INFO - '_': '/tools/buildbot/bin/python'} 22:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:20 INFO - Downloading/unpacking jsonschema==2.5.1 22:41:20 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 22:41:20 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 22:41:20 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 22:41:20 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 22:41:20 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 22:41:20 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 22:41:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:41:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:41:22 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 22:41:22 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 22:41:22 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 22:41:22 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 22:41:22 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 22:41:22 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 22:41:22 INFO - Downloading functools32-3.2.3-2.tar.gz 22:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:41:22 INFO - warning: no files found matching '*.txt' 22:41:22 INFO - no previously-included directories found matching 'build' 22:41:22 INFO - no previously-included directories found matching 'dist' 22:41:22 INFO - no previously-included directories found matching '.git*' 22:41:22 INFO - Installing collected packages: jsonschema, functools32 22:41:22 INFO - Running setup.py install for functools32 22:41:22 INFO - warning: no files found matching '*.txt' 22:41:22 INFO - no previously-included directories found matching 'build' 22:41:22 INFO - no previously-included directories found matching 'dist' 22:41:22 INFO - no previously-included directories found matching '.git*' 22:41:22 INFO - Successfully installed jsonschema functools32 22:41:22 INFO - Cleaning up... 22:41:22 INFO - Return code: 0 22:41:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:41:22 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')]} 22:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:22 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')]} 22:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:22 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:22 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 22:41:22 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 22:41:22 INFO - Using env: {'DISPLAY': ':0', 22:41:22 INFO - 'HOME': '/home/cltbld', 22:41:22 INFO - 'LANG': 'en_US.UTF-8', 22:41:22 INFO - 'LANGUAGE': 'en_US:en', 22:41:22 INFO - 'LOGNAME': 'cltbld', 22:41:22 INFO - 'MAIL': '/var/mail/cltbld', 22:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:22 INFO - 'MOZ_NO_REMOTE': '1', 22:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:22 INFO - 'NO_EM_RESTART': '1', 22:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:22 INFO - 'PWD': '/builds/slave/test', 22:41:22 INFO - 'SHELL': '/bin/bash', 22:41:22 INFO - 'SHLVL': '1', 22:41:22 INFO - 'TERM': 'linux', 22:41:22 INFO - 'TMOUT': '86400', 22:41:22 INFO - 'USER': 'cltbld', 22:41:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:22 INFO - '_': '/tools/buildbot/bin/python'} 22:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:23 INFO - Downloading/unpacking blobuploader==1.2.4 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:24 INFO - Downloading blobuploader-1.2.4.tar.gz 22:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:41:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:41:24 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 22:41:24 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 22:41:24 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 22:41:24 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 22:41:24 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 22:41:24 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 22:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:41:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:25 INFO - Downloading docopt-0.6.1.tar.gz 22:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:41:25 INFO - Installing collected packages: blobuploader, requests, docopt 22:41:25 INFO - Running setup.py install for blobuploader 22:41:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:41:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:41:25 INFO - Running setup.py install for requests 22:41:26 INFO - Running setup.py install for docopt 22:41:26 INFO - Successfully installed blobuploader requests docopt 22:41:26 INFO - Cleaning up... 22:41:26 INFO - Return code: 0 22:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:26 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:26 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 22:41:26 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 22:41:26 INFO - Using env: {'DISPLAY': ':0', 22:41:26 INFO - 'HOME': '/home/cltbld', 22:41:26 INFO - 'LANG': 'en_US.UTF-8', 22:41:26 INFO - 'LANGUAGE': 'en_US:en', 22:41:26 INFO - 'LOGNAME': 'cltbld', 22:41:26 INFO - 'MAIL': '/var/mail/cltbld', 22:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:26 INFO - 'MOZ_NO_REMOTE': '1', 22:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:26 INFO - 'NO_EM_RESTART': '1', 22:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:26 INFO - 'PWD': '/builds/slave/test', 22:41:26 INFO - 'SHELL': '/bin/bash', 22:41:26 INFO - 'SHLVL': '1', 22:41:26 INFO - 'TERM': 'linux', 22:41:26 INFO - 'TMOUT': '86400', 22:41:26 INFO - 'USER': 'cltbld', 22:41:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:26 INFO - '_': '/tools/buildbot/bin/python'} 22:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:26 INFO - Running setup.py (path:/tmp/pip-4mdXJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:26 INFO - Running setup.py (path:/tmp/pip-VmZokF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:26 INFO - Running setup.py (path:/tmp/pip-egLEYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:26 INFO - Running setup.py (path:/tmp/pip-j3NhU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:26 INFO - Running setup.py (path:/tmp/pip-t6MAbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:26 INFO - Running setup.py (path:/tmp/pip-OHjHtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:26 INFO - Running setup.py (path:/tmp/pip-EY3A70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:27 INFO - Running setup.py (path:/tmp/pip-Rgnk_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:27 INFO - Running setup.py (path:/tmp/pip-a4HPLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:27 INFO - Running setup.py (path:/tmp/pip-MeY7Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:27 INFO - Running setup.py (path:/tmp/pip-v2AOmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:27 INFO - Running setup.py (path:/tmp/pip-WooRxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:27 INFO - Running setup.py (path:/tmp/pip-YkIevl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:27 INFO - Running setup.py (path:/tmp/pip-2C8RFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:27 INFO - Running setup.py (path:/tmp/pip-yeL4wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:27 INFO - Running setup.py (path:/tmp/pip-rPCbVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:27 INFO - Running setup.py (path:/tmp/pip-XCRbt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:41:27 INFO - Running setup.py install for manifestparser 22:41:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:41:27 INFO - Running setup.py install for mozcrash 22:41:27 INFO - Running setup.py install for mozdebug 22:41:28 INFO - Running setup.py install for mozdevice 22:41:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Running setup.py install for mozfile 22:41:28 INFO - Running setup.py install for mozhttpd 22:41:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Running setup.py install for mozinfo 22:41:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Running setup.py install for mozInstall 22:41:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Running setup.py install for mozleak 22:41:28 INFO - Running setup.py install for mozlog 22:41:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Running setup.py install for moznetwork 22:41:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:41:28 INFO - Running setup.py install for mozprocess 22:41:29 INFO - Running setup.py install for mozprofile 22:41:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:41:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:41:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:41:29 INFO - Running setup.py install for mozrunner 22:41:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:41:29 INFO - Running setup.py install for mozscreenshot 22:41:29 INFO - Running setup.py install for moztest 22:41:29 INFO - Running setup.py install for mozversion 22:41:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:41:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:41:29 INFO - Cleaning up... 22:41:29 INFO - Return code: 0 22:41:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:29 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:29 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 22:41:29 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 22:41:29 INFO - Using env: {'DISPLAY': ':0', 22:41:29 INFO - 'HOME': '/home/cltbld', 22:41:29 INFO - 'LANG': 'en_US.UTF-8', 22:41:29 INFO - 'LANGUAGE': 'en_US:en', 22:41:29 INFO - 'LOGNAME': 'cltbld', 22:41:29 INFO - 'MAIL': '/var/mail/cltbld', 22:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:29 INFO - 'MOZ_NO_REMOTE': '1', 22:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:29 INFO - 'NO_EM_RESTART': '1', 22:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:29 INFO - 'PWD': '/builds/slave/test', 22:41:29 INFO - 'SHELL': '/bin/bash', 22:41:29 INFO - 'SHLVL': '1', 22:41:29 INFO - 'TERM': 'linux', 22:41:29 INFO - 'TMOUT': '86400', 22:41:29 INFO - 'USER': 'cltbld', 22:41:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:29 INFO - '_': '/tools/buildbot/bin/python'} 22:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:29 INFO - Running setup.py (path:/tmp/pip-n47dqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:29 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)) 22:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:29 INFO - Running setup.py (path:/tmp/pip-33qcfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:29 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)) 22:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:29 INFO - Running setup.py (path:/tmp/pip-70oQcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:30 INFO - Running setup.py (path:/tmp/pip-zaYYBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:30 INFO - Running setup.py (path:/tmp/pip-toBecv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:30 INFO - Running setup.py (path:/tmp/pip-gLM2n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:30 INFO - Running setup.py (path:/tmp/pip-FIWYng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:30 INFO - Running setup.py (path:/tmp/pip-f145Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:30 INFO - Running setup.py (path:/tmp/pip-qGEU2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:30 INFO - Running setup.py (path:/tmp/pip-JbZWgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:30 INFO - Running setup.py (path:/tmp/pip-rzru6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:30 INFO - Running setup.py (path:/tmp/pip-Q5dMSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:30 INFO - Running setup.py (path:/tmp/pip-ofgWEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:30 INFO - Running setup.py (path:/tmp/pip-J1eGsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:30 INFO - Running setup.py (path:/tmp/pip-HfFKOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:30 INFO - Running setup.py (path:/tmp/pip-MaQFj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:30 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)) 22:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:30 INFO - Running setup.py (path:/tmp/pip-i2EOqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:31 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)) 22:41:31 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)) 22:41:31 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)) 22:41:31 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)) 22:41:31 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)) 22:41:31 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)) 22:41:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:32 INFO - Downloading blessings-1.6.tar.gz 22:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:41:33 INFO - Installing collected packages: blessings 22:41:33 INFO - Running setup.py install for blessings 22:41:33 INFO - Successfully installed blessings 22:41:33 INFO - Cleaning up... 22:41:33 INFO - Return code: 0 22:41:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:41:33 INFO - Reading from file tmpfile_stdout 22:41:33 INFO - Current package versions: 22:41:33 INFO - argparse == 1.2.1 22:41:33 INFO - blessings == 1.6 22:41:33 INFO - blobuploader == 1.2.4 22:41:33 INFO - docopt == 0.6.1 22:41:33 INFO - functools32 == 3.2.3-2 22:41:33 INFO - jsonschema == 2.5.1 22:41:33 INFO - manifestparser == 1.1 22:41:33 INFO - mozInstall == 1.12 22:41:33 INFO - mozcrash == 0.17 22:41:33 INFO - mozdebug == 0.1 22:41:33 INFO - mozdevice == 0.48 22:41:33 INFO - mozfile == 1.2 22:41:33 INFO - mozhttpd == 0.7 22:41:33 INFO - mozinfo == 0.9 22:41:33 INFO - mozleak == 0.1 22:41:33 INFO - mozlog == 3.2 22:41:33 INFO - moznetwork == 0.27 22:41:33 INFO - mozprocess == 0.23 22:41:33 INFO - mozprofile == 0.28 22:41:33 INFO - mozrunner == 6.12 22:41:33 INFO - mozscreenshot == 0.1 22:41:33 INFO - mozsystemmonitor == 0.3 22:41:33 INFO - moztest == 0.7 22:41:33 INFO - mozversion == 1.4 22:41:33 INFO - psutil == 3.1.1 22:41:33 INFO - requests == 1.2.3 22:41:33 INFO - wsgiref == 0.1.2 22:41:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:33 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 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:33 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 22:41:33 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 22:41:33 INFO - Using env: {'DISPLAY': ':0', 22:41:33 INFO - 'HOME': '/home/cltbld', 22:41:33 INFO - 'LANG': 'en_US.UTF-8', 22:41:33 INFO - 'LANGUAGE': 'en_US:en', 22:41:33 INFO - 'LOGNAME': 'cltbld', 22:41:33 INFO - 'MAIL': '/var/mail/cltbld', 22:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:33 INFO - 'MOZ_NO_REMOTE': '1', 22:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:33 INFO - 'NO_EM_RESTART': '1', 22:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:33 INFO - 'PWD': '/builds/slave/test', 22:41:33 INFO - 'SHELL': '/bin/bash', 22:41:33 INFO - 'SHLVL': '1', 22:41:33 INFO - 'TERM': 'linux', 22:41:33 INFO - 'TMOUT': '86400', 22:41:33 INFO - 'USER': 'cltbld', 22:41:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:33 INFO - '_': '/tools/buildbot/bin/python'} 22:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 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)) 22:41:33 INFO - Cleaning up... 22:41:33 INFO - Return code: 0 22:41:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, '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-1467869532.633553-1140972771', '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 22:41:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:41:33 INFO - Using env: {'DISPLAY': ':0', 22:41:33 INFO - 'HOME': '/home/cltbld', 22:41:33 INFO - 'LANG': 'en_US.UTF-8', 22:41:33 INFO - 'LANGUAGE': 'en_US:en', 22:41:33 INFO - 'LOGNAME': 'cltbld', 22:41:33 INFO - 'MAIL': '/var/mail/cltbld', 22:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:33 INFO - 'MOZ_NO_REMOTE': '1', 22:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:33 INFO - 'NO_EM_RESTART': '1', 22:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:33 INFO - 'PWD': '/builds/slave/test', 22:41:33 INFO - 'SHELL': '/bin/bash', 22:41:33 INFO - 'SHLVL': '1', 22:41:33 INFO - 'TERM': 'linux', 22:41:33 INFO - 'TMOUT': '86400', 22:41:33 INFO - 'USER': 'cltbld', 22:41:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:33 INFO - '_': '/tools/buildbot/bin/python'} 22:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:41:33 INFO - Cleaning up... 22:41:33 INFO - Return code: 0 22:41:33 INFO - Running post-action listener: _resource_record_post_action 22:41:33 INFO - Running post-action listener: _start_resource_monitoring 22:41:33 INFO - Starting resource monitoring. 22:41:33 INFO - ##### 22:41:33 INFO - ##### Finished create-virtualenv step (success) 22:41:33 INFO - ##### 22:41:33 INFO - ##### 22:41:33 INFO - ##### Running install step. 22:41:33 INFO - ##### 22:41:33 INFO - Running pre-action listener: _resource_record_pre_action 22:41:33 INFO - Running main action method: install 22:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:41:34 INFO - Reading from file tmpfile_stdout 22:41:34 INFO - Detecting whether we're running mozinstall >=1.0... 22:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:41:34 INFO - Reading from file tmpfile_stdout 22:41:34 INFO - Output received: 22:41:34 INFO - Usage: mozinstall [options] installer 22:41:34 INFO - Options: 22:41:34 INFO - -h, --help show this help message and exit 22:41:34 INFO - -d DEST, --destination=DEST 22:41:34 INFO - Directory to install application into. [default: 22:41:34 INFO - "/builds/slave/test"] 22:41:34 INFO - --app=APP Application being installed. [default: firefox] 22:41:34 INFO - mkdir: /builds/slave/test/build/application 22:41:34 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'] 22:41:34 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 22:41:50 INFO - Reading from file tmpfile_stdout 22:41:50 INFO - Output received: 22:41:50 INFO - /builds/slave/test/build/application/firefox/firefox 22:41:50 INFO - Running post-action listener: _resource_record_post_action 22:41:50 INFO - ##### 22:41:50 INFO - ##### Finished install step (success) 22:41:50 INFO - ##### 22:41:50 INFO - ##### 22:41:50 INFO - ##### Running run-tests step. 22:41:50 INFO - ##### 22:41:50 INFO - Running pre-action listener: _resource_record_pre_action 22:41:50 INFO - Running main action method: run_tests 22:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:41:50 INFO - Python 2.7.3 22:41:50 INFO - Return code: 0 22:41:50 INFO - grabbing minidump binary from tooltool 22:41:50 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')]} 22:41:50 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 0x117b3b0>, '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 0x117c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:41:50 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 22:41:50 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 22:41:50 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 22:41:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:41:50 INFO - Return code: 0 22:41:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:41:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:41:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:41:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:41:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:50 INFO - Using env: {'DISPLAY': ':0', 22:41:50 INFO - 'HOME': '/home/cltbld', 22:41:50 INFO - 'LANG': 'en_US.UTF-8', 22:41:50 INFO - 'LANGUAGE': 'en_US:en', 22:41:50 INFO - 'LOGNAME': 'cltbld', 22:41:50 INFO - 'MAIL': '/var/mail/cltbld', 22:41:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:41:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:50 INFO - 'MOZ_NO_REMOTE': '1', 22:41:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:50 INFO - 'NO_EM_RESTART': '1', 22:41:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:50 INFO - 'PWD': '/builds/slave/test', 22:41:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:41:50 INFO - 'SHELL': '/bin/bash', 22:41:50 INFO - 'SHLVL': '1', 22:41:50 INFO - 'TERM': 'linux', 22:41:50 INFO - 'TMOUT': '86400', 22:41:50 INFO - 'USER': 'cltbld', 22:41:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467869532.633553-1140972771', 22:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:50 INFO - '_': '/tools/buildbot/bin/python'} 22:41:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/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 22:41:50 INFO - mozversion application_buildid: 20160706212522 22:41:50 INFO - mozversion application_changeset: 9beedb6cbef90bfe3e2b691a17c5c616c7e65b18 22:41:50 INFO - mozversion application_display_name: Nightly 22:41:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:41:50 INFO - mozversion application_name: Firefox 22:41:50 INFO - mozversion application_remotingname: firefox 22:41:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:41:50 INFO - mozversion application_vendor: Mozilla 22:41:50 INFO - mozversion application_version: 50.0a1 22:41:50 INFO - mozversion platform_buildid: 20160706212522 22:41:50 INFO - mozversion platform_changeset: 9beedb6cbef90bfe3e2b691a17c5c616c7e65b18 22:41:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:41:50 INFO - mozversion platform_version: 50.0a1 22:41:50 INFO - using testdate: 1467870110 22:41:50 INFO - actual date: 1467870110 22:41:50 INFO - starting webserver on 'localhost:42536' 22:41:50 INFO - SUITE-START | Running 2 tests 22:41:50 INFO - TEST-START | dromaeo_css 22:41:50 INFO - operating with platform_type : linux_ 22:41:50 INFO - Initialising browser for dromaeo_css test... 22:41:50 INFO - TEST-INFO | started process 15045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeUHA6a/profile http://localhost:42536/getInfo.html) 22:41:54 INFO - PROCESS | 15045 | __metrics Screen width/height:1600/1200 22:41:54 INFO - PROCESS | 15045 | colorDepth:24 22:41:54 INFO - PROCESS | 15045 | Browser inner width/height: 1024/697 22:41:54 INFO - PROCESS | 15045 | __metrics 22:41:55 INFO - PROCESS | 15045 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:41:56 INFO - TEST-INFO | 15045: exit 0 22:41:56 INFO - Browser initialized. 22:41:56 INFO - Running cycle 1/1 for dromaeo_css test... 22:41:56 INFO - TEST-INFO | started process 15128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeUHA6a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:08 INFO - PROCESS | 15128 | RSS: Main: 158707712 22:42:08 INFO - PROCESS | 15128 | 22:42:59 INFO - PROCESS | 15128 | 1467870179678 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] 22:45:12 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42536/tests/dromaeo/cssquery-ext.html) 22:45:13 INFO - PROCESS | 15128 | RSS: Main: 247640064 22:45:13 INFO - PROCESS | 15128 | 22:48:16 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-ext.html (next: http://localhost:42536/tests/dromaeo/cssquery-jquery.html) 22:48:16 INFO - PROCESS | 15128 | RSS: Main: 247685120 22:48:16 INFO - PROCESS | 15128 | 22:51:19 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42536/tests/dromaeo/cssquery-mootools.html) 22:51:19 INFO - PROCESS | 15128 | RSS: Main: 244883456 22:51:19 INFO - PROCESS | 15128 | 22:54:22 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42536/tests/dromaeo/cssquery-prototype.html) 22:54:22 INFO - PROCESS | 15128 | RSS: Main: 244957184 22:54:22 INFO - PROCESS | 15128 | 22:57:25 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42536/tests/dromaeo/cssquery-yui.html) 22:57:26 INFO - PROCESS | 15128 | RSS: Main: 224247808 22:57:26 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-yui.html (next: http://localhost:42536/tests/dromaeo/cssquery-dojo.html) 23:00:29 INFO - PROCESS | 15128 | RSS: Main: 296824832 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | __start_tp_report 23:00:29 INFO - PROCESS | 15128 | _x_x_mozilla_page_load 23:00:29 INFO - PROCESS | 15128 | _x_x_mozilla_page_load_details 23:00:29 INFO - PROCESS | 15128 | |i|pagename|runs| 23:00:29 INFO - PROCESS | 15128 | |0;dojo.html;2662.5340565401057;2687.5028119797853;2700.554408522594;2718.9864050679757;2724.0738149029326;4724.976375118128;4789.497102804207;4790.520947905216;4836.056968891067;4893.657443978923;4836.903261934759;4853.733044682541;4861.927071093927;4871.439784424792;4889.3888263967;4408.11837632474;4417.072414792898;4480.059187570614;4519.412476378083;4575.725456472623;4497.100579884036;4539.841105561306;4555.681102322838;4561.384213131235;4572.039871626962;4335.523092459827;4378.6934914555995;4392.736435813861;4414.53647367025;4461.977690111561;4408.1624491346865;4408.713433626804;4422.5356337584735;4453.421055262827;4471.77641117946;4438.489573699034;4450.577195166454;4456.153330867125;4486.528914463967;4495.100979804052;4631.073785242965;4793.3768610080815;4823.734694591796;4868.878278043042;4907.9263811042865;5215.58275337972;5245.186996015624;5251.6061295402615;5258.842234732964;5262.473752624745;5263.999840030382;5292.788288468457;5298;5300.893982120375;5312.707801070939;4703.223968045303;4838.975805121022;4880.023995200974;4888.071266459361;4902.754862256837;5402.864928376744;5415.214793854869;5430.212619170198;5430.619856609999;5482.890342193134;5186.533212010937;5222.503862133091;5235.083860324504;5238.8166414176085;5244.763985620656;5070.7464626768515;5171.948280517222;5222.033923724123;5227.712475813791;5282.392524859691;5190.24741412493;5195;5197.480251974848;5197.558207552324;5218.191180367049;5146.382434107931;5146.87132821675;5157.200633901752;5161.019406312788;5219.16493361068;4228.090960443519;4262.296721041055;4264.488261408589;4320.675949303814;4374.737515749065;3804.524434445694;3818.6181381861593;3823.598522155189;3848.9230215395537;3852.114013776847;4473.7986790594505;4486.439195100613;4504.301833215857;4547.522510136454;4550.431196100488;5279.788808447696;5283.577313814885;5288.92066619001;5289.18017707256;5326.174442961347;4351.43431353922;4427.933580996288;4483.887902802456;4493.168763778712;4543.227651299287;4673.766311684402;4694.460137084211;4720.409948756405;4723.669343146015;4775.021120670254;4981.227909674007;4985.651004429655;4986.052649996489;4989.226669866031;5024.2463630454995;5012.8496145115705;5126.641135120506;5149.124648809637;5249.740345576488;5302.151655735064;4898.681585696918;4911.582515486224;4932.778024988812;4938.7530623467965;4946.802127914843;5023.4725353838785;5026.246063090565;5033.295338652519;5034.119029169954;5080.568151707146;5040.470750571284;5117.385913690381;5129.281900533853;5133.666311689728;5134.12719837621;4990.525900039491;5031.195008798574;5035.194368900959;5047.141985862486;5085.56772674312;5021.924671129863;5029.145045342374;5031.496850314939;5032.773525191448;5079.441261461162;4821.132196204717;4901.5588597026435;4915.016996600622;4948.134076536519;4960.592953680505;5032.924506132338;5046.646734728533;5048.823291184791;5050.696958182521;5087.567556757717;4924.532169443897;4926.605871530197;4927.063857866994;4931.654784165074;4972.105021096238 23:00:29 INFO - PROCESS | 15128 | |1;ext.html;584.2550747796558;590.4243362721345;591.8757061017186;592.4490224091599;592.955528335375;27400.86299568502;40084.799576002115;41537;41557.96105097374;45826.54173458264;41054.384184237184;41346.17307653845;41424.79287603558;41462.792686036606;41463.792681036626;7828.256315650018;7977.202279772035;7984.441089123764;7984.760457186294;7985.680572777111;7865;7927.4847134936335;7938.047434307891;7940.483868548555;7952.085510166347;7978.720744773905;8019.719309824157;8020.438569300151;8025.0771161316325;8025.357971362277;7879.369650427952;7988.121306656263;8029.478083924526;8037.7588672339925;8041.8793718094275;7614.657340419694;7678.846423071507;7685.692572297102;7687.96156019222;7689.307962283421;38117.23765524674;38298.80850595757;38496.422553661716;38509.422358664364;38612;2966.7774916881103;3065.546486481089;3103.9912028590575;3120.563121163039;3204.4712622417273;30028.84985575058;30103.397932041455;30459.69540304591;30493.69506304953;30739;3512.543369361992;3570.250247448039;3598.2803439312243;3629.709623230135;3691.741578089535;261817;261975;262839;263269.68365158245;263435;33362.66637333595;51646;51942.74028629833;51989;52039.47960520422;33676.32647347039;33806.154846129044;33885.49171762425;33923.32153356919;34045;13568.796468052988;13731.313434328444;13747.725045499034;13748.587542373745;13757.862421375658;10903.509342079626;10934.56261749521;10974;10974.122070234362;10978;7884.724034658874;7902.920970790334;7917.841643167105;7980;7990.280874721303;3071.3089554850426;3089.8609562569736;3112.144160355875;3137.905862824119;3138.52922061688;864.9524276164746;885.3979294080087;906.8186362727481;922.6171138977384;974.0357046524032;27414.5887811683;28265.57601635977;28922.710772892424;28949.710502895123;29106;891.462227657299;924.542351535994;955.2262667239559;966.1111777165025;995.6714284286168;14837.143596171718;14962.850371496363;15108.773368399483;15297.46458873934;15385.9230703848;396074;398865;400250;401043;401064;49225.50774492209;50657;50700.492995070315;50764.969401224276;50800.491995079574;1082.8538147350164;1111.627604752417;1166.370160113563;1196.174639498743;1204.9457774400173;25531.48937021212;29183.207745968597;29563.704362956094;29996.550051748804;30005.549916751705;42458.36312455254;42827.78586107049;42953.57046429496;42981.14037719165;43156.78421607872;242348;246471;246973;248804;248941;21888.89055554712;24144.396390090387;24353.634695479228;24712.25863224106;25075.122370716937;41450;41885;42082.57917420909;42135;42631.78684106684;36335.81832090823;36496.81751591225;36678.63321366859;36800.26399471942;36822.631773682995;35647.64352356443;37018.25963480769;37247.62752372442;37399;37648;34709.305813884086;34930.301393972484;35301.64698353086;35534.289314213056;36202;31830.204244894063;32403.35193296168;32457.188570284987;32553.963971112877;32609;24761.62857557102;24902.75097249077;24965;25092.3689960152;25522.361940951625 23:00:29 INFO - PROCESS | 15128 | |2;jquery.html;347.97564170508076;354.86160397444985;367.8859553538403;371.1778410820033;390.3072047116368;13105.148165369244;13777;14819.259037048145;16947.57631059224;17209.397671081515;15794.052356858596;15887.126208058553;16078.678426431465;16107.194640267999;16181.110038947852;3715.3683873741393;3731.7574357666663;4790.23356262998;5831.387704291052;6169.969150154243;5752;6108.053251745987;6118;6124.601900876429;6250.531210159256;5952.55355848311;6122.234720659918;6135.263768347782;6164.84587885302;6197.1324014637985;6204.720787564571;6216.782412615559;6219.906701399483;6228.128062071313;6259.90610140846;5179.715115668637;5241.240020197089;5243.344581927259;5249.317588713481;5251.816186433494;20794.440416968788;20916;21439;21486.677699834516;21496.89251553732;1932.8044564920158;1947.4547126804375;1959.7452331196996;2134.8292136629034;2550.60465627828;12533.913717539688;13372.665683357896;13506.662333441644;13759.38082786267;14033.78949315761;1755.5084576318652;1773.4768243368108;1781.2518742128336;1831.8168183181576;1838.4760343302094;72026.63986680032;73017.26982730158;74549.25450745477;75298.62350688266;76832;8665.220130188187;8997.595108220015;9986.850197247048;10052.447115408722;10175.44035078063;13403.798943015863;13456.663583410298;13504.05471616997;13512.25682587467;13513.797293040612;7499.475036747484;7576.24237576249;7701.92298077012;7831.882521762178;7839.412044096715;7504.137024242173;7535.321821036133;7570.318671319497;7717.729879454192;7748.961255193801;5343.332083489564;5772.9711351442975;6200.906986395207;6276.560640755195;6334.778282760081;1675.4219794170992;1812.5378028602622;1823.5623450372082;1851.7314989326742;1868.2620364956038;870.3776799588325;872.7032808845023;879.2350654930124;923.0446487885141;953.8950715421298;16002.679946401007;16152.757708634379;16880.324787008383;17580.208890599955;17714.645707085787;857.6612238166015;868.5266529741306;891.3003292415423;923.5520772425368;934.1312579301315;9829.852552211723;9982.750431239278;10160.08559229673;10171.593136274467;10229.969882521837;379019;383204;385785;387552;388526;44172.337414938804;59071.81856362935;70242;70271.61057084372;72204.75078621475;913.0139449394638;924.8057907839294;931.8602209668468;939.5490164720973;942.514604978423;15380.92309538445;15417;15600.609984750472;15771.605709857346;16017.759733603772;35333.29333413369;35649.46525802167;35884.461733074546;36054.4591831128;36312.63687363092;44535.55464445444;47496;47937.280940786615;47947.28079078747;47966.52033479621;7808.88286675689;7810.88283675734;7859.371250299848;7877.684892604231;8016.519008859487;12187.878121218675;12203.572874949334;12321.93839030799;12364.258144511357;12442.626721198378;10131.13885319756;10243.23175761806;10397.63608273737;10536.157107431234;10668.8933110671;10855.457227138453;10897.237193396386;10936.289141205796;10953.397563134104;11119.332840029625;10642.8935710645;10731.853330007483;10894.56421743153;10924.672259832218;10958.232923695265;6115.4190351916495;6426.935730642821;6474.611523308617;7817.335526480313;8082.595870206584;9681.273904457054;10312.948435257777;10609.628662996758;10637.202209834139;10791.460426978463 23:00:29 INFO - PROCESS | 15128 | |3;mootools.html;1268.0236218112059;1390.638434007158;1424.7862820576913;1502.5267040882122;1673.8493535581804;6664.466842652589;7530.510516816403;7739.110002349731;7764.611769411535;7785.26040026198;7482.2517748225155;7723.382129429632;7728.459007869451;7924.366050715943;8005.079415867177;2185.267935241692;2232.3079845247944;2234.2850287907877;2240.19353032908;2240.249516411996;2209.823214142865;2237.9440513987197;2247.4606094537276;2252.200468833557;2253.2902135827244;2214.4242496950746;2223.344113486525;2231.3975226688785;2233.062113912161;2246.1913711064003;2126.5002724359765;2133.7226160599103;2146.5170336674278;2152.311260396674;2153.12798316682;2159.222679835258;2159.967600485994;2165.0473791531676;2166.458385403649;2167.219800871685;7677.923220767777;7818;7954;7955.721549745731;7962.6416811243635;4650.325702773079;4755.429348478205;4764.118638051971;4770.856874293742;4775.689580177312;2880.1071667782844;2947.5578663200477;2989.7309242168094;3009.142394417602;3017.4719424100695;908.4821651658557;925.3291363761286;930.7533503621546;935.4153653966271;940.1679513630486;10757.569697212102;10908;10970.835437468364;10980.780384392267;11012.889871101346;4163.75017498951;4220.113776107052;4419.46966364032;4448.822047118144;4452.287633978548;9341.34610577253;9392.29557783169;9406.623735050658;9406.90593094074;9417.670381536613;4786.234202527578;4789.928151077736;4793.209120495149;4794.400699912511;4797.376341075638;3550.8934731958084;3874.4575759393706;4272.423222864873;4360.018995726;4363.280058790264;3683.8710645127294;3690.3541880170865;3735.7945313008045;3754.249150169977;3779.6598306152578;1138.4023387721513;1184.466989854569;1209.1173443386376;1213.9271643701406;1220.682622518134;799.2566912771063;831.5301854452215;837.6900546797724;855.4653341661461;861.9269010082487;4903.779329930162;5402.081646120169;5431.837044888581;5438.700871452029;5710.343310519261;402.243781690426;406.34375483593783;408.4710300161298;413.7724251661574;421.8860907554943;3610.3862343401684;3734.9626503734617;3777.981110094432;3807.600201978808;3825.732198746117;9549.904500955041;9803.852942205873;9853.556589953469;9910.900890991143;9927.851082233772;9809.705708828747;9849.113579777855;9851.211903047739;9851.211903047739;9908.455034973002;7475.0656167979005;7558.395328373717;7560.659770310349;7571.810704732426;7575.583342916082;5423.430539793265;5460.808871689472;5477.972610136924;5650.095984642602;5655.406182350958;8890.555472226233;8908.975467821283;8913.331500137387;9013.233875120426;9045.77385565366;8296.128906464975;9075.339915709965;9335.159835614828;9410.811783764424;9544.57049432791;7199.388052015637;7512.39900807945;7520.285572870568;7525.661345239587;7675.808104797425;7235.927640723736;7389.667464963982;7427.517211381243;7496.58768767723;7573.886391704239;6678.131842860591;6915.965420172867;6941.409980151541;7016.614086225102;7103.644817759195;6748.291429400038;6781.38967492928;6799.728010879509;6818.522703410714;6841.110655614738;6428.389303016206;6477.514186435942;6527.445167160655;6528.445082168069;6529.314421985623;4473.396091527602;4530.796114174936;4698.577128058491;4710.26990816424;4801.423829140525;4623.306504024289;4639.814407423665;4698.060387922361;4720.244760838249;4756.286557016475 23:00:29 INFO - PROCESS | 15128 | |4;prototype.html;286.36855733108496;291.31976834092393;297.59675639508464;304.36236085401083;308.857925354337;4801.6398770092255;4810.591099756516;4853.684510506823;4861.7812198451065;4974.651774375795;4598.747068911217;4720.291956206571;4741.312509686093;4756.833510827113;4881.4874438184015;3711.740178187528;3764.9435258471144;3775.660190582847;3793.59636934334;3855.667321270633;3827.6937844972476;3835.616438356156;3845;3846.5384153901573;3850.441685955535;3645.8723944661942;3824.3307421201316;3828.1960788234505;3830.2148059647843;3839.808009599523;3820.9617903820886;3836.9808150959348;3850.306944749944;3854.961450385488;3858.9002134391703;3401.3027329397414;3404.455287154068;3409.437442821931;3411.3177364527196;3427.503012063237;4790.113828941657;4793.7775867154005;4806.990531988286;4808.3989501312335;4823.758812059383;4176.976640723012;4372.185542999651;4382.517923028464;4402.2296098183015;4440.111977604492;5047.64666473347;5051.166557518042;5056.544910958031;5062.139436295838;5122.436531981479;3707.1834800947613;3724.8639165054647;3739.635033212885;3744.157564547982;3772.9245415091546;5097.413797413271;5174.249733788617;5245.895082098336;5301.951377957651;5381.192821076831;3813.7139714521522;3814.771113733185;3823.636754508317;3835.884923452301;3858.151206734514;3917.8628747993685;3918.2555314490155;3919.9020024499046;3922.117523557177;3926.2343842950922;4366.454193225847;4394.648428125743;4403.493598236179;4408.404865343202;4408.911821763547;4875.805427670243;5093.516115968977;5105.757843769234;5108;5131.538161565477;1284.8436407233378;1317.953871614489;1338.116842883692;1341.9060665753304;1348.730253949214;914.9908500914905;929.8326301265837;935.5836652689624;946.3186505715873;946.9725347997362;4427.180971520214;4434.379186913835;4449.488308844459;4464.241079016575;4473.4408198975125;5201.193814958688;5205.401378841481;5211.4527974562125;5236.659617124875;5241.764120614582;4379.671524635665;4458.9331160032625;4467.441569803775;4477.1493416250805;4479.328100784843;2709.2955831483564;2741.7121202273875;2750.0787236276074;2765.9351149807467;2773.5285001549787;4907.312976183337;4907.5828554572545;4917.409910810654;4923.77842997066;4951.801927922915;5156.510131537498;5297.417284098746;5300.913312770873;5311.707856067954;5317.361916569959;4832.202686556749;4843.927341089816;4849.563539281411;4879.780409881564;4911.238757992517;5152.892128192457;5154.201098829687;5156.303898973741;5156.905856486228;5157.226416037474;4852.209979262009;5132.563732082815;5135.8716032098;5138.537531622172;5148.790034341851;4908.582770464551;4939.283803848493;4950.554450099508;4954.826581069645;4967.776450059829;3698.7780733156096;3728.7762734236035;3734.122481216966;3734.607866174121;3738.1776009277914;5097.490250974873;5110.3356563646485;5204.713740744295;5224.746060945422;5235.89528209426;5036.773345199402;5059.139946209079;5065.606043950488;5072.1123803335;5076.670016448919;4949.698784777951;4954.256861470664;5016.197408414636;5044.545990860694;5067.214581739836;4754.857354279377;4855.927161092657;4875.04936537386;4973.179425394769;4985.1276026695905;5054.3969855525165;5073.11220536412;5078.603384069411;5085.694858308513;5087.516685914832;4936.358273424432;4936.75316234194;4937.506249375034;4940.184869496493;4943.492234868256 23:00:29 INFO - PROCESS | 15128 | |5;yui.html;644.9554910932344;653.2194028136378;668.261570964085;697.3793323941693;714.4106112457221;12728.936355318223;13339.266340351276;13760.999999999975;13776.793348099787;13784.241866697315;13469.124506907045;13630.795538066937;13632.795508067362;13662.863371366284;13669.248191349472;622.1880446017944;754.4944886925746;773.7833406646148;793.5794029164553;793.7658390774735;795.3041089047084;795.4392153531775;797.7487091566167;798.1380109481775;798.6765360029168;840.5335039053323;842.0737189091981;842.3050982939069;843.0768308701962;843.5613480989912;643.4466358931315;657.6481582353418;658.3844105761128;662.973481060757;835.3609488741118;571.2887455118363;594.8542607061254;596.7791916990698;599.4904331318388;599.8770252098309;12679.112462127654;12718.618441446772;12721;12724.745505089939;12731;11731.7067073323;12373.69065773354;12395;12551.623451296477;12651.304178270191;11701.941490292495;11714.765704685944;11770.58802941893;12070.155089143764;12255.387230638433;4034.495688038995;4062.4921884764403;4104.384342348671;4232.068944832132;4234;55830.44169558293;56669;57116.42883571153;57243.71378143166;57635;9398.389104708172;9479.857802132974;9554.283428742872;9594.18449431806;9957.850632240523;18996.715049274273;19050.047497625063;19077;19083.61832763337;19095.61808763817;6508.869822603521;6549.377809108127;6607.339266073451;6663.833404164935;6830.112085428962;3556.6798988091195;3664.1206110533813;3718.0704823794053;3728.8508459661853;3742.1954279829965;2769.127724766692;2898.130560831742;2900.448914706199;2902.811317264371;2906.3170155013554;508.1742168975415;508.506748453999;519.7920831667363;521.0438844719905;521.2025600830735;517.9611529135329;541.6452223793343;556.0436049994004;556.977945470067;581.8225441240378;7745.806354841174;7860.213978602094;7915.366770658334;8102.594870256464;8175.264226219669;469.09230638714195;523.6282239609843;539.0889396919194;544.7439703339425;548.9176623506506;3707.240015796809;3998.6801055915457;4513.210188217115;4571.337156112411;4724.385829842098;60026.699866500385;60864.39135608676;76273.61863190649;107747;108540.457297713;90811.54594226986;92936;94081;94084;94258;79882.60058699669;80949.19050809534;81489.59255203804;82253.17746822455;83536;8981.824510803299;9032.774180645274;9036.412633178823;9049.276057915482;9123;44670.55329446664;45203.77398112988;45458;46220;46476.767616161706;66171.33828661652;69391;69728.65135674289;69882.65058674673;70912;10259.435731034566;10301.227407944285;10374.377537347784;10382.584696612354;10808.405537695187;11091.611793587186;11890.583829565923;13235.404406801525;13400.731985360433;13954.23251721165;12130.211536250115;12552.560660376843;12692.746145077232;12854.110824356956;13010.674733131747;12072.094592905743;12576.30830304342;12637.494500219887;12761.425735842095;13130.934345328213;12098.516059357527;12168.634940951786;12569.1201615886;12794.168379055332;13241.470341186245;9503.414400383515;9600.519974001132;9670.75823104428;10435.217358697977;10646.254762166574;9794.510274486105;9836.704898853046;9863.605455781688;10285.177185824967;10438.11276041545 23:00:29 INFO - PROCESS | 15128 | __end_tp_report 23:00:29 INFO - PROCESS | 15128 | __start_cc_report 23:00:29 INFO - PROCESS | 15128 | _x_x_mozilla_cycle_collect,888 23:00:29 INFO - PROCESS | 15128 | __end_cc_report 23:00:29 INFO - PROCESS | 15128 | __startTimestamp1467871229488__endTimestamp 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | ------- Summary: start ------- 23:00:29 INFO - PROCESS | 15128 | Number of tests: 6 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | [#0] dojo.html Cycles:165 Average:4800.36 Median:4927.06 stddev:516.01 (10.5%) stddev-sans-first:489.58 23:00:29 INFO - PROCESS | 15128 | Values: 2662.5 2687.5 2700.6 2719.0 2724.1 4725.0 4789.5 4790.5 4836.1 4893.7 4836.9 4853.7 4861.9 4871.4 4889.4 4408.1 4417.1 4480.1 4519.4 4575.7 4497.1 4539.8 4555.7 4561.4 4572.0 4335.5 4378.7 4392.7 4414.5 4462.0 4408.2 4408.7 4422.5 4453.4 4471.8 4438.5 4450.6 4456.2 4486.5 4495.1 4631.1 4793.4 4823.7 4868.9 4907.9 5215.6 5245.2 5251.6 5258.8 5262.5 5264.0 5292.8 5298.0 5300.9 5312.7 4703.2 4839.0 4880.0 4888.1 4902.8 5402.9 5415.2 5430.2 5430.6 5482.9 5186.5 5222.5 5235.1 5238.8 5244.8 5070.7 5171.9 5222.0 5227.7 5282.4 5190.2 5195.0 5197.5 5197.6 5218.2 5146.4 5146.9 5157.2 5161.0 5219.2 4228.1 4262.3 4264.5 4320.7 4374.7 3804.5 3818.6 3823.6 3848.9 3852.1 4473.8 4486.4 4504.3 4547.5 4550.4 5279.8 5283.6 5288.9 5289.2 5326.2 4351.4 4427.9 4483.9 4493.2 4543.2 4673.8 4694.5 4720.4 4723.7 4775.0 4981.2 4985.7 4986.1 4989.2 5024.2 5012.8 5126.6 5149.1 5249.7 5302.2 4898.7 4911.6 4932.8 4938.8 4946.8 5023.5 5026.2 5033.3 5034.1 5080.6 5040.5 5117.4 5129.3 5133.7 5134.1 4990.5 5031.2 5035.2 5047.1 5085.6 5021.9 5029.1 5031.5 5032.8 5079.4 4821.1 4901.6 4915.0 4948.1 4960.6 5032.9 5046.6 5048.8 5050.7 5087.6 4924.5 4926.6 4927.1 4931.7 4972.1 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | [#1] ext.html Cycles:180 Average:45114.35 Median:36811.45 stddev:81935.37 (222.6%) stddev-sans-first:82097.01 23:00:29 INFO - PROCESS | 15128 | Values: 584.3 590.4 591.9 592.4 593.0 27400.9 40084.8 41537.0 41558.0 45826.5 41054.4 41346.2 41424.8 41462.8 41463.8 7828.3 7977.2 7984.4 7984.8 7985.7 7865.0 7927.5 7938.0 7940.5 7952.1 7978.7 8019.7 8020.4 8025.1 8025.4 7879.4 7988.1 8029.5 8037.8 8041.9 7614.7 7678.8 7685.7 7688.0 7689.3 38117.2 38298.8 38496.4 38509.4 38612.0 2966.8 3065.5 3104.0 3120.6 3204.5 30028.8 30103.4 30459.7 30493.7 30739.0 3512.5 3570.3 3598.3 3629.7 3691.7 261817.0 261975.0 262839.0 263269.7 263435.0 33362.7 51646.0 51942.7 51989.0 52039.5 33676.3 33806.2 33885.5 33923.3 34045.0 13568.8 13731.3 13747.7 13748.6 13757.9 10903.5 10934.6 10974.0 10974.1 10978.0 7884.7 7902.9 7917.8 7980.0 7990.3 3071.3 3089.9 3112.1 3137.9 3138.5 865.0 885.4 906.8 922.6 974.0 27414.6 28265.6 28922.7 28949.7 29106.0 891.5 924.5 955.2 966.1 995.7 14837.1 14962.9 15108.8 15297.5 15385.9 396074.0 398865.0 400250.0 401043.0 401064.0 49225.5 50657.0 50700.5 50765.0 50800.5 1082.9 1111.6 1166.4 1196.2 1204.9 25531.5 29183.2 29563.7 29996.6 30005.5 42458.4 42827.8 42953.6 42981.1 43156.8 242348.0 246471.0 246973.0 248804.0 248941.0 21888.9 24144.4 24353.6 24712.3 25075.1 41450.0 41885.0 42082.6 42135.0 42631.8 36335.8 36496.8 36678.6 36800.3 36822.6 35647.6 37018.3 37247.6 37399.0 37648.0 34709.3 34930.3 35301.6 35534.3 36202.0 31830.2 32403.4 32457.2 32554.0 32609.0 24761.6 24902.8 24965.0 25092.4 25522.4 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | [#2] jquery.html Cycles:180 Average:24032.99 Median:381111.50 stddev:63317.20 (16.6%) stddev-sans-first:63469.85 23:00:29 INFO - PROCESS | 15128 | Values: 348.0 354.9 367.9 371.2 390.3 13105.1 13777.0 14819.3 16947.6 17209.4 15794.1 15887.1 16078.7 16107.2 16181.1 3715.4 3731.8 4790.2 5831.4 6170.0 5752.0 6108.1 6118.0 6124.6 6250.5 5952.6 6122.2 6135.3 6164.8 6197.1 6204.7 6216.8 6219.9 6228.1 6259.9 5179.7 5241.2 5243.3 5249.3 5251.8 20794.4 20916.0 21439.0 21486.7 21496.9 1932.8 1947.5 1959.7 2134.8 2550.6 12533.9 13372.7 13506.7 13759.4 14033.8 1755.5 1773.5 1781.3 1831.8 1838.5 72026.6 73017.3 74549.3 75298.6 76832.0 8665.2 8997.6 9986.9 10052.4 10175.4 13403.8 13456.7 13504.1 13512.3 13513.8 7499.5 7576.2 7701.9 7831.9 7839.4 7504.1 7535.3 7570.3 7717.7 7749.0 5343.3 5773.0 6200.9 6276.6 6334.8 1675.4 1812.5 1823.6 1851.7 1868.3 870.4 872.7 879.2 923.0 953.9 16002.7 16152.8 16880.3 17580.2 17714.6 857.7 868.5 891.3 923.6 934.1 9829.9 9982.8 10160.1 10171.6 10230.0 379019.0 383204.0 385785.0 387552.0 388526.0 44172.3 59071.8 70242.0 70271.6 72204.8 913.0 924.8 931.9 939.5 942.5 15380.9 15417.0 15600.6 15771.6 16017.8 35333.3 35649.5 35884.5 36054.5 36312.6 44535.6 47496.0 47937.3 47947.3 47966.5 7808.9 7810.9 7859.4 7877.7 8016.5 12187.9 12203.6 12321.9 12364.3 12442.6 10131.1 10243.2 10397.6 10536.2 10668.9 10855.5 10897.2 10936.3 10953.4 11119.3 10642.9 10731.9 10894.6 10924.7 10958.2 6115.4 6426.9 6474.6 7817.3 8082.6 9681.3 10312.9 10609.6 10637.2 10791.5 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | [#3] mootools.html Cycles:180 Average:5232.59 Median:5152.93 stddev:2957.63 (57.4%) stddev-sans-first:2950.92 23:00:29 INFO - PROCESS | 15128 | Values: 1268.0 1390.6 1424.8 1502.5 1673.8 6664.5 7530.5 7739.1 7764.6 7785.3 7482.3 7723.4 7728.5 7924.4 8005.1 2185.3 2232.3 2234.3 2240.2 2240.2 2209.8 2237.9 2247.5 2252.2 2253.3 2214.4 2223.3 2231.4 2233.1 2246.2 2126.5 2133.7 2146.5 2152.3 2153.1 2159.2 2160.0 2165.0 2166.5 2167.2 7677.9 7818.0 7954.0 7955.7 7962.6 4650.3 4755.4 4764.1 4770.9 4775.7 2880.1 2947.6 2989.7 3009.1 3017.5 908.5 925.3 930.8 935.4 940.2 10757.6 10908.0 10970.8 10980.8 11012.9 4163.8 4220.1 4419.5 4448.8 4452.3 9341.3 9392.3 9406.6 9406.9 9417.7 4786.2 4789.9 4793.2 4794.4 4797.4 3550.9 3874.5 4272.4 4360.0 4363.3 3683.9 3690.4 3735.8 3754.2 3779.7 1138.4 1184.5 1209.1 1213.9 1220.7 799.3 831.5 837.7 855.5 861.9 4903.8 5402.1 5431.8 5438.7 5710.3 402.2 406.3 408.5 413.8 421.9 3610.4 3735.0 3778.0 3807.6 3825.7 9549.9 9803.9 9853.6 9910.9 9927.9 9809.7 9849.1 9851.2 9851.2 9908.5 7475.1 7558.4 7560.7 7571.8 7575.6 5423.4 5460.8 5478.0 5650.1 5655.4 8890.6 8909.0 8913.3 9013.2 9045.8 8296.1 9075.3 9335.2 9410.8 9544.6 7199.4 7512.4 7520.3 7525.7 7675.8 7235.9 7389.7 7427.5 7496.6 7573.9 6678.1 6916.0 6941.4 7016.6 7103.6 6748.3 6781.4 6799.7 6818.5 6841.1 6428.4 6477.5 6527.4 6528.4 6529.3 4473.4 4530.8 4698.6 4710.3 4801.4 4623.3 4639.8 4698.1 4720.2 4756.3 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | [#4] prototype.html Cycles:180 Average:4228.61 Median:4817.17 stddev:1200.30 (24.9%) stddev-sans-first:1166.63 23:00:29 INFO - PROCESS | 15128 | Values: 286.4 291.3 297.6 304.4 308.9 4801.6 4810.6 4853.7 4861.8 4974.7 4598.7 4720.3 4741.3 4756.8 4881.5 3711.7 3764.9 3775.7 3793.6 3855.7 3827.7 3835.6 3845.0 3846.5 3850.4 3645.9 3824.3 3828.2 3830.2 3839.8 3821.0 3837.0 3850.3 3855.0 3858.9 3401.3 3404.5 3409.4 3411.3 3427.5 4790.1 4793.8 4807.0 4808.4 4823.8 4177.0 4372.2 4382.5 4402.2 4440.1 5047.6 5051.2 5056.5 5062.1 5122.4 3707.2 3724.9 3739.6 3744.2 3772.9 5097.4 5174.2 5245.9 5302.0 5381.2 3813.7 3814.8 3823.6 3835.9 3858.2 3917.9 3918.3 3919.9 3922.1 3926.2 4366.5 4394.6 4403.5 4408.4 4408.9 4875.8 5093.5 5105.8 5108.0 5131.5 1284.8 1318.0 1338.1 1341.9 1348.7 915.0 929.8 935.6 946.3 947.0 4427.2 4434.4 4449.5 4464.2 4473.4 5201.2 5205.4 5211.5 5236.7 5241.8 4379.7 4458.9 4467.4 4477.1 4479.3 2709.3 2741.7 2750.1 2765.9 2773.5 4907.3 4907.6 4917.4 4923.8 4951.8 5156.5 5297.4 5300.9 5311.7 5317.4 4832.2 4843.9 4849.6 4879.8 4911.2 5152.9 5154.2 5156.3 5156.9 5157.2 4852.2 5132.6 5135.9 5138.5 5148.8 4908.6 4939.3 4950.6 4954.8 4967.8 3698.8 3728.8 3734.1 3734.6 3738.2 5097.5 5110.3 5204.7 5224.7 5235.9 5036.8 5059.1 5065.6 5072.1 5076.7 4949.7 4954.3 5016.2 5044.5 5067.2 4754.9 4855.9 4875.0 4973.2 4985.1 5054.4 5073.1 5078.6 5085.7 5087.5 4936.4 4936.8 4937.5 4940.2 4943.5 23:00:29 INFO - PROCESS | 15128 | 23:00:29 INFO - PROCESS | 15128 | [#5] yui.html Cycles:180 Average:17987.68 Median:520.42 stddev:25677.58 (4934.0%) stddev-sans-first:25716.59 23:00:29 INFO - PROCESS | 15128 | Values: 645.0 653.2 668.3 697.4 714.4 12728.9 13339.3 13761.0 13776.8 13784.2 13469.1 13630.8 13632.8 13662.9 13669.2 622.2 754.5 773.8 793.6 793.8 795.3 795.4 797.7 798.1 798.7 840.5 842.1 842.3 843.1 843.6 643.4 657.6 658.4 663.0 835.4 571.3 594.9 596.8 599.5 599.9 12679.1 12718.6 12721.0 12724.7 12731.0 11731.7 12373.7 12395.0 12551.6 12651.3 11701.9 11714.8 11770.6 12070.2 12255.4 4034.5 4062.5 4104.4 4232.1 4234.0 55830.4 56669.0 57116.4 57243.7 57635.0 9398.4 9479.9 9554.3 9594.2 9957.9 18996.7 19050.0 19077.0 19083.6 19095.6 6508.9 6549.4 6607.3 6663.8 6830.1 3556.7 3664.1 3718.1 3728.9 3742.2 2769.1 2898.1 2900.4 2902.8 2906.3 508.2 508.5 519.8 521.0 521.2 518.0 541.6 556.0 557.0 581.8 7745.8 7860.2 7915.4 8102.6 8175.3 469.1 523.6 539.1 544.7 548.9 3707.2 3998.7 4513.2 4571.3 4724.4 60026.7 60864.4 76273.6 107747.0 108540.5 90811.5 92936.0 94081.0 94084.0 94258.0 79882.6 80949.2 81489.6 82253.2 83536.0 8981.8 9032.8 9036.4 9049.3 9123.0 44670.6 45203.8 45458.0 46220.0 46476.8 66171.3 69391.0 69728.7 69882.7 70912.0 10259.4 10301.2 10374.4 10382.6 10808.4 11091.6 11890.6 13235.4 13400.7 13954.2 12130.2 12552.6 12692.7 12854.1 13010.7 12072.1 12576.3 12637.5 12761.4 13130.9 12098.5 12168.6 12569.1 12794.2 13241.5 9503.4 9600.5 9670.8 10435.2 10646.3 9794.5 9836.7 9863.6 10285.2 10438.1 23:00:29 INFO - PROCESS | 15128 | -------- Summary: end -------- 23:00:29 INFO - PROCESS | 15128 | 23:00:30 INFO - TEST-INFO | 15128: exit 0 23:00:30 INFO - TEST-OK | dromaeo_css | took 1119501ms 23:00:30 INFO - TEST-START | kraken 23:00:30 INFO - operating with platform_type : linux_ 23:00:30 INFO - Initialising browser for kraken test... 23:00:30 INFO - TEST-INFO | started process 15314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0Brtl/profile http://localhost:42536/getInfo.html) 23:00:34 INFO - PROCESS | 15314 | __metrics Screen width/height:1600/1200 23:00:34 INFO - PROCESS | 15314 | colorDepth:24 23:00:34 INFO - PROCESS | 15314 | Browser inner width/height: 1024/697 23:00:34 INFO - PROCESS | 15314 | __metrics 23:00:35 INFO - PROCESS | 15314 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:00:35 INFO - TEST-INFO | 15314: exit 0 23:00:35 INFO - Browser initialized. 23:00:35 INFO - Running cycle 1/1 for kraken test... 23:00:35 INFO - TEST-INFO | started process 15396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0Brtl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:47 INFO - PROCESS | 15396 | RSS: Main: 159387648 23:00:47 INFO - PROCESS | 15396 | 23:00:50 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-beat-detection) 23:00:51 INFO - PROCESS | 15396 | RSS: Main: 216993792 23:00:51 INFO - PROCESS | 15396 | 23:00:54 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-dft) 23:00:54 INFO - PROCESS | 15396 | RSS: Main: 203980800 23:00:54 INFO - PROCESS | 15396 | 23:00:58 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-fft) 23:00:58 INFO - PROCESS | 15396 | RSS: Main: 271515648 23:00:58 INFO - PROCESS | 15396 | 23:01:00 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-oscillator) 23:01:01 INFO - PROCESS | 15396 | RSS: Main: 182009856 23:01:01 INFO - PROCESS | 15396 | 23:01:03 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:04 INFO - PROCESS | 15396 | RSS: Main: 185544704 23:01:04 INFO - PROCESS | 15396 | 23:01:07 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42536/tests/kraken/driver.html?testName=imaging-darkroom) 23:01:08 INFO - PROCESS | 15396 | RSS: Main: 221696000 23:01:08 INFO - PROCESS | 15396 | 23:01:11 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42536/tests/kraken/driver.html?testName=imaging-desaturate) 23:01:12 INFO - PROCESS | 15396 | RSS: Main: 222019584 23:01:12 INFO - PROCESS | 15396 | 23:01:15 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42536/tests/kraken/driver.html?testName=json-parse-financial) 23:01:15 INFO - PROCESS | 15396 | RSS: Main: 222408704 23:01:15 INFO - PROCESS | 15396 | 23:01:17 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:01:17 INFO - PROCESS | 15396 | RSS: Main: 207015936 23:01:17 INFO - PROCESS | 15396 | 23:01:19 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:01:20 INFO - PROCESS | 15396 | RSS: Main: 210767872 23:01:20 INFO - PROCESS | 15396 | 23:01:22 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:01:23 INFO - PROCESS | 15396 | RSS: Main: 210563072 23:01:23 INFO - PROCESS | 15396 | 23:01:26 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:01:26 INFO - PROCESS | 15396 | RSS: Main: 230486016 23:01:26 INFO - PROCESS | 15396 | 23:01:29 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:01:30 INFO - PROCESS | 15396 | RSS: Main: 226496512 23:01:30 INFO - PROCESS | 15396 | 23:01:31 INFO - PROCESS | 15396 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42536/tests/kraken/driver.html?testName=ai-astar) 23:01:32 INFO - PROCESS | 15396 | RSS: Main: 268460032 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | __start_tp_report 23:01:32 INFO - PROCESS | 15396 | _x_x_mozilla_page_load 23:01:32 INFO - PROCESS | 15396 | _x_x_mozilla_page_load_details 23:01:32 INFO - PROCESS | 15396 | |i|pagename|runs| 23:01:32 INFO - PROCESS | 15396 | |0;ai-astar;103;113;112;113;112;112;112;114;110;111 23:01:32 INFO - PROCESS | 15396 | |1;audio-beat-detection;144;127;129;177;128;124;147;123;177;128 23:01:32 INFO - PROCESS | 15396 | |2;audio-dft;161;162;162;161;162;161;160;163;161;159 23:01:32 INFO - PROCESS | 15396 | |3;audio-fft;76;75;76;123;77;79;76;75;110;75 23:01:32 INFO - PROCESS | 15396 | |4;audio-oscillator;86;85;127;87;85;85;126;85;86;134 23:01:32 INFO - PROCESS | 15396 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;116;117 23:01:32 INFO - PROCESS | 15396 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;145;146 23:01:32 INFO - PROCESS | 15396 | |7;imaging-desaturate;95;94;95;94;95;95;95;95;95;95 23:01:32 INFO - PROCESS | 15396 | |8;json-parse-financial;64;65;63;64;65;65;65;67;64;65 23:01:32 INFO - PROCESS | 15396 | |9;json-stringify-tinderbox;64;65;64;65;66;65;65;66;65;65 23:01:32 INFO - PROCESS | 15396 | |10;stanford-crypto-aes;79;78;84;78;79;79;76;78;77;86 23:01:32 INFO - PROCESS | 15396 | |11;stanford-crypto-ccm;130;140;128;133;128;133;130;127;178;143 23:01:32 INFO - PROCESS | 15396 | |12;stanford-crypto-pbkdf2;171;172;165;174;165;165;165;166;165;162 23:01:32 INFO - PROCESS | 15396 | |13;stanford-crypto-sha256-iterative;75;66;66;67;70;76;67;70;66;66 23:01:32 INFO - PROCESS | 15396 | __end_tp_report 23:01:32 INFO - PROCESS | 15396 | __start_cc_report 23:01:32 INFO - PROCESS | 15396 | _x_x_mozilla_cycle_collect,1927 23:01:32 INFO - PROCESS | 15396 | __end_cc_report 23:01:32 INFO - PROCESS | 15396 | __startTimestamp1467871292214__endTimestamp 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | ------- Summary: start ------- 23:01:32 INFO - PROCESS | 15396 | Number of tests: 14 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.08 (2.8%) stddev-sans-first:1.17 23:01:32 INFO - PROCESS | 15396 | Values: 103.0 113.0 112.0 113.0 112.0 112.0 112.0 114.0 110.0 111.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:136.50 stddev:20.88 (15.3%) stddev-sans-first:22.11 23:01:32 INFO - PROCESS | 15396 | Values: 144.0 127.0 129.0 177.0 128.0 124.0 147.0 123.0 177.0 128.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 23:01:32 INFO - PROCESS | 15396 | Values: 161.0 162.0 162.0 161.0 162.0 161.0 160.0 163.0 161.0 159.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:17.34 (22.8%) stddev-sans-first:18.13 23:01:32 INFO - PROCESS | 15396 | Values: 76.0 75.0 76.0 123.0 77.0 79.0 76.0 75.0 110.0 75.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:85.00 stddev:21.09 (24.8%) stddev-sans-first:21.87 23:01:32 INFO - PROCESS | 15396 | Values: 86.0 85.0 127.0 87.0 85.0 85.0 126.0 85.0 86.0 134.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:01:32 INFO - PROCESS | 15396 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:01:32 INFO - PROCESS | 15396 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:01:32 INFO - PROCESS | 15396 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 23:01:32 INFO - PROCESS | 15396 | Values: 64.0 65.0 63.0 64.0 65.0 65.0 65.0 67.0 64.0 65.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 23:01:32 INFO - PROCESS | 15396 | Values: 64.0 65.0 64.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:3.13 (4.0%) stddev-sans-first:3.32 23:01:32 INFO - PROCESS | 15396 | Values: 79.0 78.0 84.0 78.0 79.0 79.0 76.0 78.0 77.0 86.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:133.00 stddev:15.34 (11.5%) stddev-sans-first:16.06 23:01:32 INFO - PROCESS | 15396 | Values: 130.0 140.0 128.0 133.0 128.0 133.0 130.0 127.0 178.0 143.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:165.50 stddev:3.89 (2.3%) stddev-sans-first:3.84 23:01:32 INFO - PROCESS | 15396 | Values: 171.0 172.0 165.0 174.0 165.0 165.0 165.0 166.0 165.0 162.0 23:01:32 INFO - PROCESS | 15396 | 23:01:32 INFO - PROCESS | 15396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:3.81 (5.6%) stddev-sans-first:3.35 23:01:32 INFO - PROCESS | 15396 | Values: 75.0 66.0 66.0 67.0 70.0 76.0 67.0 70.0 66.0 66.0 23:01:32 INFO - PROCESS | 15396 | -------- Summary: end -------- 23:01:32 INFO - PROCESS | 15396 | 23:01:33 INFO - TEST-INFO | 15396: exit 0 23:01:33 INFO - TEST-OK | kraken | took 62949ms 23:01:33 INFO - SUITE-END | took 1182s 23:01:33 INFO - Completed test suite (00:19:42) 23:01:33 INFO - javascript benchmark 23:01:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.5340565401057, 2687.5028119797853, 2700.554408522594, 2718.9864050679757, 2724.0738149029326, 4724.976375118128, 4789.497102804207, 4790.520947905216, 4836.056968891067, 4893.657443978923, 4836.903261934759, 4853.733044682541, 4861.927071093927, 4871.439784424792, 4889.3888263967, 4408.11837632474, 4417.072414792898, 4480.059187570614, 4519.412476378083, 4575.725456472623, 4497.100579884036, 4539.841105561306, 4555.681102322838, 4561.384213131235, 4572.039871626962, 4335.523092459827, 4378.6934914555995, 4392.736435813861, 4414.53647367025, 4461.977690111561, 4408.1624491346865, 4408.713433626804, 4422.5356337584735, 4453.421055262827, 4471.77641117946, 4438.489573699034, 4450.577195166454, 4456.153330867125, 4486.528914463967, 4495.100979804052, 4631.073785242965, 4793.3768610080815, 4823.734694591796, 4868.878278043042, 4907.9263811042865, 5215.58275337972, 5245.186996015624, 5251.6061295402615, 5258.842234732964, 5262.473752624745, 5263.999840030382, 5292.788288468457, 5298.0, 5300.893982120375, 5312.707801070939, 4703.223968045303, 4838.975805121022, 4880.023995200974, 4888.071266459361, 4902.754862256837, 5402.864928376744, 5415.214793854869, 5430.212619170198, 5430.619856609999, 5482.890342193134, 5186.533212010937, 5222.503862133091, 5235.083860324504, 5238.8166414176085, 5244.763985620656, 5070.7464626768515, 5171.948280517222, 5222.033923724123, 5227.712475813791, 5282.392524859691, 5190.24741412493, 5195.0, 5197.480251974848, 5197.558207552324, 5218.191180367049, 5146.382434107931, 5146.87132821675, 5157.200633901752, 5161.019406312788, 5219.16493361068, 4228.090960443519, 4262.296721041055, 4264.488261408589, 4320.675949303814, 4374.737515749065, 3804.524434445694, 3818.6181381861593, 3823.598522155189, 3848.9230215395537, 3852.114013776847, 4473.7986790594505, 4486.439195100613, 4504.301833215857, 4547.522510136454, 4550.431196100488, 5279.788808447696, 5283.577313814885, 5288.92066619001, 5289.18017707256, 5326.174442961347, 4351.43431353922, 4427.933580996288, 4483.887902802456, 4493.168763778712, 4543.227651299287, 4673.766311684402, 4694.460137084211, 4720.409948756405, 4723.669343146015, 4775.021120670254, 4981.227909674007, 4985.651004429655, 4986.052649996489, 4989.226669866031, 5024.2463630454995, 5012.8496145115705, 5126.641135120506, 5149.124648809637, 5249.740345576488, 5302.151655735064, 4898.681585696918, 4911.582515486224, 4932.778024988812, 4938.7530623467965, 4946.802127914843, 5023.4725353838785, 5026.246063090565, 5033.295338652519, 5034.119029169954, 5080.568151707146, 5040.470750571284, 5117.385913690381, 5129.281900533853, 5133.666311689728, 5134.12719837621, 4990.525900039491, 5031.195008798574, 5035.194368900959, 5047.141985862486, 5085.56772674312, 5021.924671129863, 5029.145045342374, 5031.496850314939, 5032.773525191448, 5079.441261461162, 4821.132196204717, 4901.5588597026435, 4915.016996600622, 4948.134076536519, 4960.592953680505, 5032.924506132338, 5046.646734728533, 5048.823291184791, 5050.696958182521, 5087.567556757717, 4924.532169443897, 4926.605871530197, 4927.063857866994, 4931.654784165074, 4972.105021096238], "value": 4766.704139867322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.2550747796558, 590.4243362721345, 591.8757061017186, 592.4490224091599, 592.955528335375, 27400.86299568502, 40084.799576002115, 41537.0, 41557.96105097374, 45826.54173458264, 41054.384184237184, 41346.17307653845, 41424.79287603558, 41462.792686036606, 41463.792681036626, 7828.256315650018, 7977.202279772035, 7984.441089123764, 7984.760457186294, 7985.680572777111, 7865.0, 7927.4847134936335, 7938.047434307891, 7940.483868548555, 7952.085510166347, 7978.720744773905, 8019.719309824157, 8020.438569300151, 8025.0771161316325, 8025.357971362277, 7879.369650427952, 7988.121306656263, 8029.478083924526, 8037.7588672339925, 8041.8793718094275, 7614.657340419694, 7678.846423071507, 7685.692572297102, 7687.96156019222, 7689.307962283421, 38117.23765524674, 38298.80850595757, 38496.422553661716, 38509.422358664364, 38612.0, 2966.7774916881103, 3065.546486481089, 3103.9912028590575, 3120.563121163039, 3204.4712622417273, 30028.84985575058, 30103.397932041455, 30459.69540304591, 30493.69506304953, 30739.0, 3512.543369361992, 3570.250247448039, 3598.2803439312243, 3629.709623230135, 3691.741578089535, 261817.0, 261975.0, 262839.0, 263269.68365158245, 263435.0, 33362.66637333595, 51646.0, 51942.74028629833, 51989.0, 52039.47960520422, 33676.32647347039, 33806.154846129044, 33885.49171762425, 33923.32153356919, 34045.0, 13568.796468052988, 13731.313434328444, 13747.725045499034, 13748.587542373745, 13757.862421375658, 10903.509342079626, 10934.56261749521, 10974.0, 10974.122070234362, 10978.0, 7884.724034658874, 7902.920970790334, 7917.841643167105, 7980.0, 7990.280874721303, 3071.3089554850426, 3089.8609562569736, 3112.144160355875, 3137.905862824119, 3138.52922061688, 864.9524276164746, 885.3979294080087, 906.8186362727481, 922.6171138977384, 974.0357046524032, 27414.5887811683, 28265.57601635977, 28922.710772892424, 28949.710502895123, 29106.0, 891.462227657299, 924.542351535994, 955.2262667239559, 966.1111777165025, 995.6714284286168, 14837.143596171718, 14962.850371496363, 15108.773368399483, 15297.46458873934, 15385.9230703848, 396074.0, 398865.0, 400250.0, 401043.0, 401064.0, 49225.50774492209, 50657.0, 50700.492995070315, 50764.969401224276, 50800.491995079574, 1082.8538147350164, 1111.627604752417, 1166.370160113563, 1196.174639498743, 1204.9457774400173, 25531.48937021212, 29183.207745968597, 29563.704362956094, 29996.550051748804, 30005.549916751705, 42458.36312455254, 42827.78586107049, 42953.57046429496, 42981.14037719165, 43156.78421607872, 242348.0, 246471.0, 246973.0, 248804.0, 248941.0, 21888.89055554712, 24144.396390090387, 24353.634695479228, 24712.25863224106, 25075.122370716937, 41450.0, 41885.0, 42082.57917420909, 42135.0, 42631.78684106684, 36335.81832090823, 36496.81751591225, 36678.63321366859, 36800.26399471942, 36822.631773682995, 35647.64352356443, 37018.25963480769, 37247.62752372442, 37399.0, 37648.0, 34709.305813884086, 34930.301393972484, 35301.64698353086, 35534.289314213056, 36202.0, 31830.204244894063, 32403.35193296168, 32457.188570284987, 32553.963971112877, 32609.0, 24761.62857557102, 24902.75097249077, 24965.0, 25092.3689960152, 25522.361940951625], "value": 16472.986571701524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.97564170508076, 354.86160397444985, 367.8859553538403, 371.1778410820033, 390.3072047116368, 13105.148165369244, 13777.0, 14819.259037048145, 16947.57631059224, 17209.397671081515, 15794.052356858596, 15887.126208058553, 16078.678426431465, 16107.194640267999, 16181.110038947852, 3715.3683873741393, 3731.7574357666663, 4790.23356262998, 5831.387704291052, 6169.969150154243, 5752.0, 6108.053251745987, 6118.0, 6124.601900876429, 6250.531210159256, 5952.55355848311, 6122.234720659918, 6135.263768347782, 6164.84587885302, 6197.1324014637985, 6204.720787564571, 6216.782412615559, 6219.906701399483, 6228.128062071313, 6259.90610140846, 5179.715115668637, 5241.240020197089, 5243.344581927259, 5249.317588713481, 5251.816186433494, 20794.440416968788, 20916.0, 21439.0, 21486.677699834516, 21496.89251553732, 1932.8044564920158, 1947.4547126804375, 1959.7452331196996, 2134.8292136629034, 2550.60465627828, 12533.913717539688, 13372.665683357896, 13506.662333441644, 13759.38082786267, 14033.78949315761, 1755.5084576318652, 1773.4768243368108, 1781.2518742128336, 1831.8168183181576, 1838.4760343302094, 72026.63986680032, 73017.26982730158, 74549.25450745477, 75298.62350688266, 76832.0, 8665.220130188187, 8997.595108220015, 9986.850197247048, 10052.447115408722, 10175.44035078063, 13403.798943015863, 13456.663583410298, 13504.05471616997, 13512.25682587467, 13513.797293040612, 7499.475036747484, 7576.24237576249, 7701.92298077012, 7831.882521762178, 7839.412044096715, 7504.137024242173, 7535.321821036133, 7570.318671319497, 7717.729879454192, 7748.961255193801, 5343.332083489564, 5772.9711351442975, 6200.906986395207, 6276.560640755195, 6334.778282760081, 1675.4219794170992, 1812.5378028602622, 1823.5623450372082, 1851.7314989326742, 1868.2620364956038, 870.3776799588325, 872.7032808845023, 879.2350654930124, 923.0446487885141, 953.8950715421298, 16002.679946401007, 16152.757708634379, 16880.324787008383, 17580.208890599955, 17714.645707085787, 857.6612238166015, 868.5266529741306, 891.3003292415423, 923.5520772425368, 934.1312579301315, 9829.852552211723, 9982.750431239278, 10160.08559229673, 10171.593136274467, 10229.969882521837, 379019.0, 383204.0, 385785.0, 387552.0, 388526.0, 44172.337414938804, 59071.81856362935, 70242.0, 70271.61057084372, 72204.75078621475, 913.0139449394638, 924.8057907839294, 931.8602209668468, 939.5490164720973, 942.514604978423, 15380.92309538445, 15417.0, 15600.609984750472, 15771.605709857346, 16017.759733603772, 35333.29333413369, 35649.46525802167, 35884.461733074546, 36054.4591831128, 36312.63687363092, 44535.55464445444, 47496.0, 47937.280940786615, 47947.28079078747, 47966.52033479621, 7808.88286675689, 7810.88283675734, 7859.371250299848, 7877.684892604231, 8016.519008859487, 12187.878121218675, 12203.572874949334, 12321.93839030799, 12364.258144511357, 12442.626721198378, 10131.13885319756, 10243.23175761806, 10397.63608273737, 10536.157107431234, 10668.8933110671, 10855.457227138453, 10897.237193396386, 10936.289141205796, 10953.397563134104, 11119.332840029625, 10642.8935710645, 10731.853330007483, 10894.56421743153, 10924.672259832218, 10958.232923695265, 6115.4190351916495, 6426.935730642821, 6474.611523308617, 7817.335526480313, 8082.595870206584, 9681.273904457054, 10312.948435257777, 10609.628662996758, 10637.202209834139, 10791.460426978463], "value": 8461.694732647964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.0236218112059, 1390.638434007158, 1424.7862820576913, 1502.5267040882122, 1673.8493535581804, 6664.466842652589, 7530.510516816403, 7739.110002349731, 7764.611769411535, 7785.26040026198, 7482.2517748225155, 7723.382129429632, 7728.459007869451, 7924.366050715943, 8005.079415867177, 2185.267935241692, 2232.3079845247944, 2234.2850287907877, 2240.19353032908, 2240.249516411996, 2209.823214142865, 2237.9440513987197, 2247.4606094537276, 2252.200468833557, 2253.2902135827244, 2214.4242496950746, 2223.344113486525, 2231.3975226688785, 2233.062113912161, 2246.1913711064003, 2126.5002724359765, 2133.7226160599103, 2146.5170336674278, 2152.311260396674, 2153.12798316682, 2159.222679835258, 2159.967600485994, 2165.0473791531676, 2166.458385403649, 2167.219800871685, 7677.923220767777, 7818.0, 7954.0, 7955.721549745731, 7962.6416811243635, 4650.325702773079, 4755.429348478205, 4764.118638051971, 4770.856874293742, 4775.689580177312, 2880.1071667782844, 2947.5578663200477, 2989.7309242168094, 3009.142394417602, 3017.4719424100695, 908.4821651658557, 925.3291363761286, 930.7533503621546, 935.4153653966271, 940.1679513630486, 10757.569697212102, 10908.0, 10970.835437468364, 10980.780384392267, 11012.889871101346, 4163.75017498951, 4220.113776107052, 4419.46966364032, 4448.822047118144, 4452.287633978548, 9341.34610577253, 9392.29557783169, 9406.623735050658, 9406.90593094074, 9417.670381536613, 4786.234202527578, 4789.928151077736, 4793.209120495149, 4794.400699912511, 4797.376341075638, 3550.8934731958084, 3874.4575759393706, 4272.423222864873, 4360.018995726, 4363.280058790264, 3683.8710645127294, 3690.3541880170865, 3735.7945313008045, 3754.249150169977, 3779.6598306152578, 1138.4023387721513, 1184.466989854569, 1209.1173443386376, 1213.9271643701406, 1220.682622518134, 799.2566912771063, 831.5301854452215, 837.6900546797724, 855.4653341661461, 861.9269010082487, 4903.779329930162, 5402.081646120169, 5431.837044888581, 5438.700871452029, 5710.343310519261, 402.243781690426, 406.34375483593783, 408.4710300161298, 413.7724251661574, 421.8860907554943, 3610.3862343401684, 3734.9626503734617, 3777.981110094432, 3807.600201978808, 3825.732198746117, 9549.904500955041, 9803.852942205873, 9853.556589953469, 9910.900890991143, 9927.851082233772, 9809.705708828747, 9849.113579777855, 9851.211903047739, 9851.211903047739, 9908.455034973002, 7475.0656167979005, 7558.395328373717, 7560.659770310349, 7571.810704732426, 7575.583342916082, 5423.430539793265, 5460.808871689472, 5477.972610136924, 5650.095984642602, 5655.406182350958, 8890.555472226233, 8908.975467821283, 8913.331500137387, 9013.233875120426, 9045.77385565366, 8296.128906464975, 9075.339915709965, 9335.159835614828, 9410.811783764424, 9544.57049432791, 7199.388052015637, 7512.39900807945, 7520.285572870568, 7525.661345239587, 7675.808104797425, 7235.927640723736, 7389.667464963982, 7427.517211381243, 7496.58768767723, 7573.886391704239, 6678.131842860591, 6915.965420172867, 6941.409980151541, 7016.614086225102, 7103.644817759195, 6748.291429400038, 6781.38967492928, 6799.728010879509, 6818.522703410714, 6841.110655614738, 6428.389303016206, 6477.514186435942, 6527.445167160655, 6528.445082168069, 6529.314421985623, 4473.396091527602, 4530.796114174936, 4698.577128058491, 4710.26990816424, 4801.423829140525, 4623.306504024289, 4639.814407423665, 4698.060387922361, 4720.244760838249, 4756.286557016475], "value": 4129.148087374662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.36855733108496, 291.31976834092393, 297.59675639508464, 304.36236085401083, 308.857925354337, 4801.6398770092255, 4810.591099756516, 4853.684510506823, 4861.7812198451065, 4974.651774375795, 4598.747068911217, 4720.291956206571, 4741.312509686093, 4756.833510827113, 4881.4874438184015, 3711.740178187528, 3764.9435258471144, 3775.660190582847, 3793.59636934334, 3855.667321270633, 3827.6937844972476, 3835.616438356156, 3845.0, 3846.5384153901573, 3850.441685955535, 3645.8723944661942, 3824.3307421201316, 3828.1960788234505, 3830.2148059647843, 3839.808009599523, 3820.9617903820886, 3836.9808150959348, 3850.306944749944, 3854.961450385488, 3858.9002134391703, 3401.3027329397414, 3404.455287154068, 3409.437442821931, 3411.3177364527196, 3427.503012063237, 4790.113828941657, 4793.7775867154005, 4806.990531988286, 4808.3989501312335, 4823.758812059383, 4176.976640723012, 4372.185542999651, 4382.517923028464, 4402.2296098183015, 4440.111977604492, 5047.64666473347, 5051.166557518042, 5056.544910958031, 5062.139436295838, 5122.436531981479, 3707.1834800947613, 3724.8639165054647, 3739.635033212885, 3744.157564547982, 3772.9245415091546, 5097.413797413271, 5174.249733788617, 5245.895082098336, 5301.951377957651, 5381.192821076831, 3813.7139714521522, 3814.771113733185, 3823.636754508317, 3835.884923452301, 3858.151206734514, 3917.8628747993685, 3918.2555314490155, 3919.9020024499046, 3922.117523557177, 3926.2343842950922, 4366.454193225847, 4394.648428125743, 4403.493598236179, 4408.404865343202, 4408.911821763547, 4875.805427670243, 5093.516115968977, 5105.757843769234, 5108.0, 5131.538161565477, 1284.8436407233378, 1317.953871614489, 1338.116842883692, 1341.9060665753304, 1348.730253949214, 914.9908500914905, 929.8326301265837, 935.5836652689624, 946.3186505715873, 946.9725347997362, 4427.180971520214, 4434.379186913835, 4449.488308844459, 4464.241079016575, 4473.4408198975125, 5201.193814958688, 5205.401378841481, 5211.4527974562125, 5236.659617124875, 5241.764120614582, 4379.671524635665, 4458.9331160032625, 4467.441569803775, 4477.1493416250805, 4479.328100784843, 2709.2955831483564, 2741.7121202273875, 2750.0787236276074, 2765.9351149807467, 2773.5285001549787, 4907.312976183337, 4907.5828554572545, 4917.409910810654, 4923.77842997066, 4951.801927922915, 5156.510131537498, 5297.417284098746, 5300.913312770873, 5311.707856067954, 5317.361916569959, 4832.202686556749, 4843.927341089816, 4849.563539281411, 4879.780409881564, 4911.238757992517, 5152.892128192457, 5154.201098829687, 5156.303898973741, 5156.905856486228, 5157.226416037474, 4852.209979262009, 5132.563732082815, 5135.8716032098, 5138.537531622172, 5148.790034341851, 4908.582770464551, 4939.283803848493, 4950.554450099508, 4954.826581069645, 4967.776450059829, 3698.7780733156096, 3728.7762734236035, 3734.122481216966, 3734.607866174121, 3738.1776009277914, 5097.490250974873, 5110.3356563646485, 5204.713740744295, 5224.746060945422, 5235.89528209426, 5036.773345199402, 5059.139946209079, 5065.606043950488, 5072.1123803335, 5076.670016448919, 4949.698784777951, 4954.256861470664, 5016.197408414636, 5044.545990860694, 5067.214581739836, 4754.857354279377, 4855.927161092657, 4875.04936537386, 4973.179425394769, 4985.1276026695905, 5054.3969855525165, 5073.11220536412, 5078.603384069411, 5085.694858308513, 5087.516685914832, 4936.358273424432, 4936.75316234194, 4937.506249375034, 4940.184869496493, 4943.492234868256], "value": 3849.8282113354066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.9554910932344, 653.2194028136378, 668.261570964085, 697.3793323941693, 714.4106112457221, 12728.936355318223, 13339.266340351276, 13760.999999999975, 13776.793348099787, 13784.241866697315, 13469.124506907045, 13630.795538066937, 13632.795508067362, 13662.863371366284, 13669.248191349472, 622.1880446017944, 754.4944886925746, 773.7833406646148, 793.5794029164553, 793.7658390774735, 795.3041089047084, 795.4392153531775, 797.7487091566167, 798.1380109481775, 798.6765360029168, 840.5335039053323, 842.0737189091981, 842.3050982939069, 843.0768308701962, 843.5613480989912, 643.4466358931315, 657.6481582353418, 658.3844105761128, 662.973481060757, 835.3609488741118, 571.2887455118363, 594.8542607061254, 596.7791916990698, 599.4904331318388, 599.8770252098309, 12679.112462127654, 12718.618441446772, 12721.0, 12724.745505089939, 12731.0, 11731.7067073323, 12373.69065773354, 12395.0, 12551.623451296477, 12651.304178270191, 11701.941490292495, 11714.765704685944, 11770.58802941893, 12070.155089143764, 12255.387230638433, 4034.495688038995, 4062.4921884764403, 4104.384342348671, 4232.068944832132, 4234.0, 55830.44169558293, 56669.0, 57116.42883571153, 57243.71378143166, 57635.0, 9398.389104708172, 9479.857802132974, 9554.283428742872, 9594.18449431806, 9957.850632240523, 18996.715049274273, 19050.047497625063, 19077.0, 19083.61832763337, 19095.61808763817, 6508.869822603521, 6549.377809108127, 6607.339266073451, 6663.833404164935, 6830.112085428962, 3556.6798988091195, 3664.1206110533813, 3718.0704823794053, 3728.8508459661853, 3742.1954279829965, 2769.127724766692, 2898.130560831742, 2900.448914706199, 2902.811317264371, 2906.3170155013554, 508.1742168975415, 508.506748453999, 519.7920831667363, 521.0438844719905, 521.2025600830735, 517.9611529135329, 541.6452223793343, 556.0436049994004, 556.977945470067, 581.8225441240378, 7745.806354841174, 7860.213978602094, 7915.366770658334, 8102.594870256464, 8175.264226219669, 469.09230638714195, 523.6282239609843, 539.0889396919194, 544.7439703339425, 548.9176623506506, 3707.240015796809, 3998.6801055915457, 4513.210188217115, 4571.337156112411, 4724.385829842098, 60026.699866500385, 60864.39135608676, 76273.61863190649, 107747.0, 108540.457297713, 90811.54594226986, 92936.0, 94081.0, 94084.0, 94258.0, 79882.60058699669, 80949.19050809534, 81489.59255203804, 82253.17746822455, 83536.0, 8981.824510803299, 9032.774180645274, 9036.412633178823, 9049.276057915482, 9123.0, 44670.55329446664, 45203.77398112988, 45458.0, 46220.0, 46476.767616161706, 66171.33828661652, 69391.0, 69728.65135674289, 69882.65058674673, 70912.0, 10259.435731034566, 10301.227407944285, 10374.377537347784, 10382.584696612354, 10808.405537695187, 11091.611793587186, 11890.583829565923, 13235.404406801525, 13400.731985360433, 13954.23251721165, 12130.211536250115, 12552.560660376843, 12692.746145077232, 12854.110824356956, 13010.674733131747, 12072.094592905743, 12576.30830304342, 12637.494500219887, 12761.425735842095, 13130.934345328213, 12098.516059357527, 12168.634940951786, 12569.1201615886, 12794.168379055332, 13241.470341186245, 9503.414400383515, 9600.519974001132, 9670.75823104428, 10435.217358697977, 10646.254762166574, 9794.510274486105, 9836.704898853046, 9863.605455781688, 10285.177185824967, 10438.11276041545], "value": 6620.352519105913, "unit": "score"}], "name": "dromaeo_css", "value": 6418.6870860957715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0, 114.0, 110.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 127.0, 129.0, 177.0, 128.0, 124.0, 147.0, 123.0, 177.0, 128.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 160.0, 163.0, 161.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 123.0, 77.0, 79.0, 76.0, 75.0, 110.0, 75.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 127.0, 87.0, 85.0, 85.0, 126.0, 85.0, 86.0, 134.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 65.0, 65.0, 65.0, 67.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 84.0, 78.0, 79.0, 79.0, 76.0, 78.0, 77.0, 86.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 140.0, 128.0, 133.0, 128.0, 133.0, 130.0, 127.0, 178.0, 143.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 165.0, 174.0, 165.0, 165.0, 165.0, 166.0, 165.0, 162.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 66.0, 66.0, 67.0, 70.0, 76.0, 67.0, 70.0, 66.0, 66.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1534.7000000000003, "alertThreshold": 2.0}]} 23:01:33 INFO - Return code: 0 23:01:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:01:33 INFO - # TBPL SUCCESS # 23:01:33 INFO - Running post-action listener: _resource_record_post_action 23:01:33 INFO - ##### 23:01:33 INFO - ##### Finished run-tests step (success) 23:01:33 INFO - ##### 23:01:33 INFO - Running post-run listener: _resource_record_post_run 23:01:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546627584; Read time: 16; Write time: 412004 23:01:33 INFO - TinderboxPrint: CPU usage
12.9% 23:01:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:01:33 INFO - TinderboxPrint: I/O write bytes / time
546,627,584 / 412,004 23:01:33 INFO - TinderboxPrint: CPU idle
8,330.8 (87.0%) 23:01:33 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 23:01:33 INFO - TinderboxPrint: Swap in / out
0 / 0 23:01:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245960704; Read time: 0; Write time: 225320 23:01:33 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288456704; Read time: 0; Write time: 183068 23:01:34 INFO - Running post-run listener: _upload_blobber_files 23:01:34 INFO - Blob upload gear active. 23:01:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:01:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:01:34 INFO - (blobuploader) - INFO - Open directory for files ... 23:01:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:01:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:01:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:01:35 INFO - (blobuploader) - INFO - Done attempting. 23:01:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:01:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:01:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:01:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:01:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:01:36 INFO - (blobuploader) - INFO - Done attempting. 23:01:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:01:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:01:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:01:40 INFO - (blobuploader) - INFO - Done attempting. 23:01:40 INFO - (blobuploader) - INFO - Iteration through files over. 23:01:40 INFO - Return code: 0 23:01:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:01:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:01:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/538830ac1de998d2dfd3c698d15d92c2f1cd3a3d304e6280b1560e7b746e4a5ebd0dd28ad7b7fa043ecef0b0474f6317bc0be2413e17379fd32c9027a2c4d8d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdb89ead25c70f1bf11be10cb32549b37e84859c98af4b2c28dce09f8ba66ad79aff3c72678376150deda99048e57dbe6502632611e39e2a377a0b7a2f375ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f8a3bfd6bdaeefcf7fcf2e45f797a62acb45a40efc438779c79771e36aab3b21dae6738e2e288e61cab9ef88c03b1dacb4fcddbdf0486a122e66aefe6737a37c"} 23:01:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:01:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:01:40 INFO - Contents: 23:01:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/538830ac1de998d2dfd3c698d15d92c2f1cd3a3d304e6280b1560e7b746e4a5ebd0dd28ad7b7fa043ecef0b0474f6317bc0be2413e17379fd32c9027a2c4d8d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdb89ead25c70f1bf11be10cb32549b37e84859c98af4b2c28dce09f8ba66ad79aff3c72678376150deda99048e57dbe6502632611e39e2a377a0b7a2f375ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f8a3bfd6bdaeefcf7fcf2e45f797a62acb45a40efc438779c79771e36aab3b21dae6738e2e288e61cab9ef88c03b1dacb4fcddbdf0486a122e66aefe6737a37c"} 23:01:40 INFO - Running post-run listener: copy_logs_to_upload_dir 23:01:40 INFO - Copying logs to upload dir... 23:01:40 INFO - mkdir: /builds/slave/test/build/upload/logs 23:01:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.896033 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-06 23:01:39.724309) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:01:39.727480) ========= 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-1467869532.633553-1140972771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/538830ac1de998d2dfd3c698d15d92c2f1cd3a3d304e6280b1560e7b746e4a5ebd0dd28ad7b7fa043ecef0b0474f6317bc0be2413e17379fd32c9027a2c4d8d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdb89ead25c70f1bf11be10cb32549b37e84859c98af4b2c28dce09f8ba66ad79aff3c72678376150deda99048e57dbe6502632611e39e2a377a0b7a2f375ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f8a3bfd6bdaeefcf7fcf2e45f797a62acb45a40efc438779c79771e36aab3b21dae6738e2e288e61cab9ef88c03b1dacb4fcddbdf0486a122e66aefe6737a37c"} build_url:https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/Zm9_0_xPS7uIv5keetigLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/538830ac1de998d2dfd3c698d15d92c2f1cd3a3d304e6280b1560e7b746e4a5ebd0dd28ad7b7fa043ecef0b0474f6317bc0be2413e17379fd32c9027a2c4d8d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fdb89ead25c70f1bf11be10cb32549b37e84859c98af4b2c28dce09f8ba66ad79aff3c72678376150deda99048e57dbe6502632611e39e2a377a0b7a2f375ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f8a3bfd6bdaeefcf7fcf2e45f797a62acb45a40efc438779c79771e36aab3b21dae6738e2e288e61cab9ef88c03b1dacb4fcddbdf0486a122e66aefe6737a37c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:01:39.752674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:01:39.752963) ========= 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-1467869532.633553-1140972771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:01:39.838244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:01:39.838521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:01:39.838772) ========= ========= Total master_lag: 0.16 =========