builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1467854312.95 results: success (0) buildid: 20160706173323 builduid: 8536eb6f8d274529a1f766cbfb3ecc25 revision: df9ad1cf01d7b32b051931f04629b696a7f9b98a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:32.949998) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:32.951943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:32.952242) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:32.988557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:32.988847) ========= 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=920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 18:18:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-06 18:18:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.084708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.085151) ========= 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=920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013710 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.134411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.134738) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df9ad1cf01d7b32b051931f04629b696a7f9b98a --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 df9ad1cf01d7b32b051931f04629b696a7f9b98a --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=920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 18:18:33,761 truncating revision to first 12 chars 2016-07-06 18:18:33,761 Setting DEBUG logging. 2016-07-06 18:18:33,761 attempt 1/10 2016-07-06 18:18:33,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df9ad1cf01d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 18:18:34,071 unpacking tar archive at: fx-team-df9ad1cf01d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.809866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.810304) ========= script_repo_revision: df9ad1cf01d7b32b051931f04629b696a7f9b98a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.810708) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.810980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 18:18:33.822619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-06 18:18:33.822894) ========= /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=920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:34 INFO - MultiFileLogger online at 20160706 18:18:34 in /builds/slave/test 18:18:34 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 18:18:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:34 INFO - {'append_to_log': False, 18:18:34 INFO - 'base_work_dir': '/builds/slave/test', 18:18:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:18:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:34 INFO - 'branch': 'Fx-Team-Non-PGO', 18:18:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:34 INFO - 'config_files': ('talos/linux_config.py',), 18:18:34 INFO - 'default_actions': ('clobber', 18:18:34 INFO - 'read-buildbot-config', 18:18:34 INFO - 'download-and-extract', 18:18:34 INFO - 'populate-webroot', 18:18:34 INFO - 'create-virtualenv', 18:18:34 INFO - 'install', 18:18:34 INFO - 'run-tests'), 18:18:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:34 INFO - 'download_minidump_stackwalk': True, 18:18:34 INFO - 'download_symbols': 'ondemand', 18:18:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:34 INFO - 'installer_path': 'installer.exe', 18:18:34 INFO - 'log_level': 'info', 18:18:34 INFO - 'log_name': 'talos', 18:18:34 INFO - 'log_to_console': True, 18:18:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:34 INFO - 'opt_config_files': (), 18:18:34 INFO - 'pip_index': False, 18:18:34 INFO - 'sps_profile': False, 18:18:34 INFO - 'sps_profile_interval': 0, 18:18:34 INFO - 'suite': 'dromaeojs', 18:18:34 INFO - 'system_bits': '32', 18:18:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:34 INFO - 'title': 'talos-linux64-ix-053', 18:18:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:34 INFO - 'use_talos_json': True, 18:18:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:34 INFO - 'work_dir': 'build'} 18:18:34 INFO - ##### 18:18:34 INFO - ##### Running clobber step. 18:18:34 INFO - ##### 18:18:34 INFO - Running pre-action listener: _resource_record_pre_action 18:18:34 INFO - Running main action method: clobber 18:18:34 INFO - rmtree: /builds/slave/test/build 18:18:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:35 INFO - Running post-action listener: _resource_record_post_action 18:18:35 INFO - ##### 18:18:35 INFO - ##### Finished clobber step (success) 18:18:35 INFO - ##### 18:18:35 INFO - ##### 18:18:35 INFO - ##### Running read-buildbot-config step. 18:18:35 INFO - ##### 18:18:35 INFO - Running pre-action listener: _resource_record_pre_action 18:18:35 INFO - Running main action method: read_buildbot_config 18:18:35 INFO - Using buildbot properties: 18:18:35 INFO - { 18:18:35 INFO - "project": "", 18:18:35 INFO - "product": "firefox", 18:18:35 INFO - "script_repo_revision": "production", 18:18:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:18:35 INFO - "repository": "", 18:18:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:18:35 INFO - "buildid": "20160706173323", 18:18:35 INFO - "pgo_build": "False", 18:18:35 INFO - "basedir": "/builds/slave/test", 18:18:35 INFO - "buildnumber": 3137, 18:18:35 INFO - "slavename": "talos-linux64-ix-053", 18:18:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:18:35 INFO - "platform": "ubuntu64_hw", 18:18:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:18:35 INFO - "branch": "fx-team", 18:18:35 INFO - "repo_path": "integration/fx-team", 18:18:35 INFO - "revision": "df9ad1cf01d7b32b051931f04629b696a7f9b98a", 18:18:35 INFO - "stage_platform": "linux64", 18:18:35 INFO - "builduid": "8536eb6f8d274529a1f766cbfb3ecc25", 18:18:35 INFO - "slavebuilddir": "test" 18:18:35 INFO - } 18:18:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:18:35 INFO - Running post-action listener: _resource_record_post_action 18:18:35 INFO - ##### 18:18:35 INFO - ##### Finished read-buildbot-config step (success) 18:18:35 INFO - ##### 18:18:35 INFO - ##### 18:18:35 INFO - ##### Running download-and-extract step. 18:18:35 INFO - ##### 18:18:35 INFO - Running pre-action listener: _resource_record_pre_action 18:18:35 INFO - Running main action method: download_and_extract 18:18:35 INFO - mkdir: /builds/slave/test/build/tests 18:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:35 INFO - https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:35 INFO - Downloaded 1361 bytes. 18:18:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:35 INFO - Using the following test package requirements: 18:18:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:18:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'jsshell-linux-x86_64.zip'], 18:18:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:18:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:18:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:35 INFO - https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:36 INFO - Downloaded 22730934 bytes. 18:18:36 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'] 18:18:36 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 18:18:38 INFO - Return code: 0 18:18:38 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 18:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:38 INFO - https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:39 INFO - Downloaded 22730934 bytes. 18:18:39 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'] 18:18:39 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 18:18:40 INFO - Return code: 0 18:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:40 INFO - https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:41 INFO - Downloaded 14403333 bytes. 18:18:41 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'] 18:18:41 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 18:18:41 INFO - Return code: 0 18:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:41 INFO - https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyyvoJPFT260Y12Fjzle3g/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 18:18:43 INFO - Downloaded 56472352 bytes. 18:18:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:43 INFO - mkdir: /builds/slave/test/properties 18:18:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:43 INFO - Contents: 18:18:43 INFO - build_url:https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:43 INFO - Running post-action listener: _resource_record_post_action 18:18:43 INFO - Running post-action listener: set_extra_try_arguments 18:18:43 INFO - ##### 18:18:43 INFO - ##### Finished download-and-extract step (success) 18:18:43 INFO - ##### 18:18:43 INFO - ##### 18:18:43 INFO - ##### Running populate-webroot step. 18:18:43 INFO - ##### 18:18:43 INFO - Running pre-action listener: _resource_record_pre_action 18:18:43 INFO - Running main action method: populate_webroot 18:18:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:43 INFO - '--tppagecycles', 18:18:43 INFO - '7'], 18:18:43 INFO - 'tests': ['tsvgm']}}, 18:18:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['damp', 'tps']}, 18:18:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'tests': ['damp', 'tps']}, 18:18:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['dromaeo_dom']}, 18:18:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['basic_compositor_video']}, 18:18:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:18:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['a11yr', 18:18:43 INFO - 'ts_paint', 18:18:43 INFO - 'tpaint', 18:18:43 INFO - 'sessionrestore', 18:18:43 INFO - 'sessionrestore_no_auto_restore', 18:18:43 INFO - 'tabpaint']}, 18:18:43 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:43 INFO - 'ts_paint', 18:18:43 INFO - 'tpaint', 18:18:43 INFO - 'sessionrestore', 18:18:43 INFO - 'sessionrestore_no_auto_restore', 18:18:43 INFO - 'tabpaint']}, 18:18:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:43 INFO - 'ts_paint', 18:18:43 INFO - 'tpaint', 18:18:43 INFO - 'sessionrestore', 18:18:43 INFO - 'sessionrestore_no_auto_restore', 18:18:43 INFO - 'tabpaint']}, 18:18:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:43 INFO - 'ts_paint', 18:18:43 INFO - 'tpaint', 18:18:43 INFO - 'sessionrestore', 18:18:43 INFO - 'sessionrestore_no_auto_restore', 18:18:43 INFO - 'tabpaint']}, 18:18:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['a11yr', 18:18:43 INFO - 'ts_paint', 18:18:43 INFO - 'tpaint', 18:18:43 INFO - 'sessionrestore', 18:18:43 INFO - 'sessionrestore_no_auto_restore', 18:18:43 INFO - 'tabpaint']}, 18:18:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['a11yr', 18:18:43 INFO - 'ts_paint', 18:18:43 INFO - 'tpaint', 18:18:43 INFO - 'sessionrestore', 18:18:43 INFO - 'sessionrestore_no_auto_restore', 18:18:43 INFO - 'tabpaint']}, 18:18:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['tsvgx', 18:18:43 INFO - 'tsvgr_opacity', 18:18:43 INFO - 'tart', 18:18:43 INFO - 'tscrollx', 18:18:43 INFO - 'cart']}, 18:18:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:43 INFO - 'tsvgr_opacity', 18:18:43 INFO - 'tart', 18:18:43 INFO - 'tscrollx', 18:18:43 INFO - 'cart']}, 18:18:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'talos_options': ['--disable-e10s'], 18:18:43 INFO - 'tests': ['tp5o']}, 18:18:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'tests': ['tp5o']}, 18:18:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'talos_options': ['--disable-e10s', 18:18:43 INFO - '--xperf_path', 18:18:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:43 INFO - 'tests': ['tp5n']}, 18:18:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:43 INFO - 'talos_options': ['--xperf_path', 18:18:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:43 INFO - 'tests': ['tp5n']}}, 18:18:43 INFO - 'talos.zip': {'path': '', 18:18:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:43 INFO - Running post-action listener: _resource_record_post_action 18:18:43 INFO - ##### 18:18:43 INFO - ##### Finished populate-webroot step (success) 18:18:43 INFO - ##### 18:18:43 INFO - ##### 18:18:43 INFO - ##### Running create-virtualenv step. 18:18:43 INFO - ##### 18:18:43 INFO - Running pre-action listener: _resource_record_pre_action 18:18:43 INFO - Running main action method: create_virtualenv 18:18:43 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:43 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 18:18:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:43 INFO - Using real prefix '/usr' 18:18:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:46 INFO - Installing pip.................done. 18:18:46 INFO - Return code: 0 18:18:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:46 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')]} 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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')]} 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:18:46 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 18:18:46 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 18:18:46 INFO - Using env: {'DISPLAY': ':0', 18:18:46 INFO - 'HOME': '/home/cltbld', 18:18:46 INFO - 'LANG': 'en_US.UTF-8', 18:18:46 INFO - 'LANGUAGE': 'en_US:en', 18:18:46 INFO - 'LOGNAME': 'cltbld', 18:18:46 INFO - 'MAIL': '/var/mail/cltbld', 18:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:46 INFO - 'MOZ_NO_REMOTE': '1', 18:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:46 INFO - 'NO_EM_RESTART': '1', 18:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:46 INFO - 'PWD': '/builds/slave/test', 18:18:46 INFO - 'SHELL': '/bin/bash', 18:18:46 INFO - 'SHLVL': '1', 18:18:46 INFO - 'TERM': 'linux', 18:18:46 INFO - 'TMOUT': '86400', 18:18:46 INFO - 'USER': 'cltbld', 18:18:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:46 INFO - '_': '/tools/buildbot/bin/python'} 18:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:46 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 18:18:46 INFO - Cleaning up... 18:18:46 INFO - Return code: 0 18:18:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:18:46 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')]} 18:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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')]} 18:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:46 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:18:46 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 18:18:46 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 18:18:46 INFO - Using env: {'DISPLAY': ':0', 18:18:46 INFO - 'HOME': '/home/cltbld', 18:18:46 INFO - 'LANG': 'en_US.UTF-8', 18:18:46 INFO - 'LANGUAGE': 'en_US:en', 18:18:46 INFO - 'LOGNAME': 'cltbld', 18:18:46 INFO - 'MAIL': '/var/mail/cltbld', 18:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:46 INFO - 'MOZ_NO_REMOTE': '1', 18:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:46 INFO - 'NO_EM_RESTART': '1', 18:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:46 INFO - 'PWD': '/builds/slave/test', 18:18:46 INFO - 'SHELL': '/bin/bash', 18:18:46 INFO - 'SHLVL': '1', 18:18:46 INFO - 'TERM': 'linux', 18:18:46 INFO - 'TMOUT': '86400', 18:18:46 INFO - 'USER': 'cltbld', 18:18:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:46 INFO - '_': '/tools/buildbot/bin/python'} 18:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:46 INFO - Downloading/unpacking psutil>=3.1.1 18:18:46 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 18:18:46 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 18:18:46 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 18:18:46 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 18:18:46 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 18:18:46 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 18:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:48 INFO - Installing collected packages: psutil 18:18:48 INFO - Running setup.py install for psutil 18:18:48 INFO - building 'psutil._psutil_linux' extension 18:18:48 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 18:18:49 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 18:18:49 INFO - building 'psutil._psutil_posix' extension 18:18:49 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 18:18:49 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 18:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:49 INFO - Successfully installed psutil 18:18:49 INFO - Cleaning up... 18:18:49 INFO - Return code: 0 18:18:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:18:49 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 18:18:49 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 18:18:49 INFO - Using env: {'DISPLAY': ':0', 18:18:49 INFO - 'HOME': '/home/cltbld', 18:18:49 INFO - 'LANG': 'en_US.UTF-8', 18:18:49 INFO - 'LANGUAGE': 'en_US:en', 18:18:49 INFO - 'LOGNAME': 'cltbld', 18:18:49 INFO - 'MAIL': '/var/mail/cltbld', 18:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:49 INFO - 'MOZ_NO_REMOTE': '1', 18:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:49 INFO - 'NO_EM_RESTART': '1', 18:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:49 INFO - 'PWD': '/builds/slave/test', 18:18:49 INFO - 'SHELL': '/bin/bash', 18:18:49 INFO - 'SHLVL': '1', 18:18:49 INFO - 'TERM': 'linux', 18:18:49 INFO - 'TMOUT': '86400', 18:18:49 INFO - 'USER': 'cltbld', 18:18:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:49 INFO - '_': '/tools/buildbot/bin/python'} 18:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:18:51 INFO - Installing collected packages: mozsystemmonitor 18:18:51 INFO - Running setup.py install for mozsystemmonitor 18:18:51 INFO - Successfully installed mozsystemmonitor 18:18:51 INFO - Cleaning up... 18:18:51 INFO - Return code: 0 18:18:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:51 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:18:51 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 18:18:51 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 18:18:51 INFO - Using env: {'DISPLAY': ':0', 18:18:51 INFO - 'HOME': '/home/cltbld', 18:18:51 INFO - 'LANG': 'en_US.UTF-8', 18:18:51 INFO - 'LANGUAGE': 'en_US:en', 18:18:51 INFO - 'LOGNAME': 'cltbld', 18:18:51 INFO - 'MAIL': '/var/mail/cltbld', 18:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:51 INFO - 'MOZ_NO_REMOTE': '1', 18:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:51 INFO - 'NO_EM_RESTART': '1', 18:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:51 INFO - 'PWD': '/builds/slave/test', 18:18:51 INFO - 'SHELL': '/bin/bash', 18:18:51 INFO - 'SHLVL': '1', 18:18:51 INFO - 'TERM': 'linux', 18:18:51 INFO - 'TMOUT': '86400', 18:18:51 INFO - 'USER': 'cltbld', 18:18:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:51 INFO - '_': '/tools/buildbot/bin/python'} 18:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:51 INFO - Downloading/unpacking jsonschema==2.5.1 18:18:51 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 18:18:51 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 18:18:51 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 18:18:51 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 18:18:51 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 18:18:51 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 18:18:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:18:53 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 18:18:53 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 18:18:53 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 18:18:53 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 18:18:53 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 18:18:53 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 18:18:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:54 INFO - warning: no files found matching '*.txt' 18:18:54 INFO - no previously-included directories found matching 'build' 18:18:54 INFO - no previously-included directories found matching 'dist' 18:18:54 INFO - no previously-included directories found matching '.git*' 18:18:54 INFO - Installing collected packages: jsonschema, functools32 18:18:54 INFO - Running setup.py install for functools32 18:18:54 INFO - warning: no files found matching '*.txt' 18:18:54 INFO - no previously-included directories found matching 'build' 18:18:54 INFO - no previously-included directories found matching 'dist' 18:18:54 INFO - no previously-included directories found matching '.git*' 18:18:54 INFO - Successfully installed jsonschema functools32 18:18:54 INFO - Cleaning up... 18:18:54 INFO - Return code: 0 18:18:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:54 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:18:54 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 18:18:54 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 18:18:54 INFO - Using env: {'DISPLAY': ':0', 18:18:54 INFO - 'HOME': '/home/cltbld', 18:18:54 INFO - 'LANG': 'en_US.UTF-8', 18:18:54 INFO - 'LANGUAGE': 'en_US:en', 18:18:54 INFO - 'LOGNAME': 'cltbld', 18:18:54 INFO - 'MAIL': '/var/mail/cltbld', 18:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:54 INFO - 'MOZ_NO_REMOTE': '1', 18:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:54 INFO - 'NO_EM_RESTART': '1', 18:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:54 INFO - 'PWD': '/builds/slave/test', 18:18:54 INFO - 'SHELL': '/bin/bash', 18:18:54 INFO - 'SHLVL': '1', 18:18:54 INFO - 'TERM': 'linux', 18:18:54 INFO - 'TMOUT': '86400', 18:18:54 INFO - 'USER': 'cltbld', 18:18:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:54 INFO - '_': '/tools/buildbot/bin/python'} 18:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:54 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 18:18:54 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 18:18:54 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 18:18:54 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 18:18:54 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 18:18:54 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 18:18:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:57 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 18:18:57 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 18:18:57 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 18:18:57 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 18:18:57 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 18:18:57 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 18:18:57 INFO - Downloading docopt-0.6.1.tar.gz 18:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:57 INFO - Running setup.py install for blobuploader 18:18:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:57 INFO - Running setup.py install for requests 18:18:57 INFO - Running setup.py install for docopt 18:18:57 INFO - Successfully installed blobuploader requests docopt 18:18:57 INFO - Cleaning up... 18:18:57 INFO - Return code: 0 18:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:57 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')]} 18:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:57 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')]} 18:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:57 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:18:57 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 18:18:57 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 18:18:57 INFO - Using env: {'DISPLAY': ':0', 18:18:57 INFO - 'HOME': '/home/cltbld', 18:18:57 INFO - 'LANG': 'en_US.UTF-8', 18:18:57 INFO - 'LANGUAGE': 'en_US:en', 18:18:57 INFO - 'LOGNAME': 'cltbld', 18:18:57 INFO - 'MAIL': '/var/mail/cltbld', 18:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:57 INFO - 'MOZ_NO_REMOTE': '1', 18:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:57 INFO - 'NO_EM_RESTART': '1', 18:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:57 INFO - 'PWD': '/builds/slave/test', 18:18:57 INFO - 'SHELL': '/bin/bash', 18:18:57 INFO - 'SHLVL': '1', 18:18:57 INFO - 'TERM': 'linux', 18:18:57 INFO - 'TMOUT': '86400', 18:18:57 INFO - 'USER': 'cltbld', 18:18:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:57 INFO - '_': '/tools/buildbot/bin/python'} 18:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:58 INFO - Running setup.py (path:/tmp/pip-OvDYCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:58 INFO - Running setup.py (path:/tmp/pip-uAgY8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:58 INFO - Running setup.py (path:/tmp/pip-VXmx99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:58 INFO - Running setup.py (path:/tmp/pip-QgSqz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:58 INFO - Running setup.py (path:/tmp/pip-CjvzFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:58 INFO - Running setup.py (path:/tmp/pip-8dqmjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:58 INFO - Running setup.py (path:/tmp/pip-PtwXUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:58 INFO - Running setup.py (path:/tmp/pip-SjKWmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:58 INFO - Running setup.py (path:/tmp/pip-akudQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:58 INFO - Running setup.py (path:/tmp/pip-ICEg_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:58 INFO - Running setup.py (path:/tmp/pip-EHs79i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:58 INFO - Running setup.py (path:/tmp/pip-5_Y_7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:59 INFO - Running setup.py (path:/tmp/pip-5jBW3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:59 INFO - Running setup.py (path:/tmp/pip-cLNZe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:59 INFO - Running setup.py (path:/tmp/pip-CllGp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:59 INFO - Running setup.py (path:/tmp/pip-TgeYmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:59 INFO - Running setup.py (path:/tmp/pip-LqFHNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:59 INFO - Running setup.py install for manifestparser 18:18:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:59 INFO - Running setup.py install for mozcrash 18:18:59 INFO - Running setup.py install for mozdebug 18:18:59 INFO - Running setup.py install for mozdevice 18:18:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:59 INFO - Running setup.py install for mozfile 18:18:59 INFO - Running setup.py install for mozhttpd 18:18:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:59 INFO - Running setup.py install for mozinfo 18:19:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Running setup.py install for mozInstall 18:19:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Running setup.py install for mozleak 18:19:00 INFO - Running setup.py install for mozlog 18:19:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Running setup.py install for moznetwork 18:19:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Running setup.py install for mozprocess 18:19:00 INFO - Running setup.py install for mozprofile 18:19:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Running setup.py install for mozrunner 18:19:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:19:00 INFO - Running setup.py install for mozscreenshot 18:19:00 INFO - Running setup.py install for moztest 18:19:01 INFO - Running setup.py install for mozversion 18:19:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:19:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:01 INFO - Cleaning up... 18:19:01 INFO - Return code: 0 18:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:01 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:19:01 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 18:19:01 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 18:19:01 INFO - Using env: {'DISPLAY': ':0', 18:19:01 INFO - 'HOME': '/home/cltbld', 18:19:01 INFO - 'LANG': 'en_US.UTF-8', 18:19:01 INFO - 'LANGUAGE': 'en_US:en', 18:19:01 INFO - 'LOGNAME': 'cltbld', 18:19:01 INFO - 'MAIL': '/var/mail/cltbld', 18:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:01 INFO - 'MOZ_NO_REMOTE': '1', 18:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:01 INFO - 'NO_EM_RESTART': '1', 18:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:01 INFO - 'PWD': '/builds/slave/test', 18:19:01 INFO - 'SHELL': '/bin/bash', 18:19:01 INFO - 'SHLVL': '1', 18:19:01 INFO - 'TERM': 'linux', 18:19:01 INFO - 'TMOUT': '86400', 18:19:01 INFO - 'USER': 'cltbld', 18:19:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:01 INFO - '_': '/tools/buildbot/bin/python'} 18:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:01 INFO - Running setup.py (path:/tmp/pip-qcZdeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:01 INFO - Running setup.py (path:/tmp/pip-ntFZd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:01 INFO - Running setup.py (path:/tmp/pip-drhhSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:01 INFO - Running setup.py (path:/tmp/pip-Y4qFsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:01 INFO - Running setup.py (path:/tmp/pip-fTCaK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:01 INFO - Running setup.py (path:/tmp/pip-qihDsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:01 INFO - Running setup.py (path:/tmp/pip-sJun6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:01 INFO - Running setup.py (path:/tmp/pip-Hr4ZOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:01 INFO - Running setup.py (path:/tmp/pip-VUPnr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:02 INFO - Running setup.py (path:/tmp/pip-wdsxLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:02 INFO - Running setup.py (path:/tmp/pip-5zYoJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:02 INFO - Running setup.py (path:/tmp/pip-3RfDzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:02 INFO - Running setup.py (path:/tmp/pip-EeU7op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:02 INFO - Running setup.py (path:/tmp/pip-H8z52w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:02 INFO - Running setup.py (path:/tmp/pip-qD7Jqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:02 INFO - Running setup.py (path:/tmp/pip-VcC4jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:02 INFO - Running setup.py (path:/tmp/pip-zZr3Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:04 INFO - Downloading blessings-1.6.tar.gz 18:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:04 INFO - Installing collected packages: blessings 18:19:04 INFO - Running setup.py install for blessings 18:19:04 INFO - Successfully installed blessings 18:19:04 INFO - Cleaning up... 18:19:04 INFO - Return code: 0 18:19:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:05 INFO - Reading from file tmpfile_stdout 18:19:05 INFO - Current package versions: 18:19:05 INFO - argparse == 1.2.1 18:19:05 INFO - blessings == 1.6 18:19:05 INFO - blobuploader == 1.2.4 18:19:05 INFO - docopt == 0.6.1 18:19:05 INFO - functools32 == 3.2.3-2 18:19:05 INFO - jsonschema == 2.5.1 18:19:05 INFO - manifestparser == 1.1 18:19:05 INFO - mozInstall == 1.12 18:19:05 INFO - mozcrash == 0.17 18:19:05 INFO - mozdebug == 0.1 18:19:05 INFO - mozdevice == 0.48 18:19:05 INFO - mozfile == 1.2 18:19:05 INFO - mozhttpd == 0.7 18:19:05 INFO - mozinfo == 0.9 18:19:05 INFO - mozleak == 0.1 18:19:05 INFO - mozlog == 3.2 18:19:05 INFO - moznetwork == 0.27 18:19:05 INFO - mozprocess == 0.22 18:19:05 INFO - mozprofile == 0.28 18:19:05 INFO - mozrunner == 6.11 18:19:05 INFO - mozscreenshot == 0.1 18:19:05 INFO - mozsystemmonitor == 0.3 18:19:05 INFO - moztest == 0.7 18:19:05 INFO - mozversion == 1.4 18:19:05 INFO - psutil == 3.1.1 18:19:05 INFO - requests == 1.2.3 18:19:05 INFO - wsgiref == 0.1.2 18:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:05 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 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:19:05 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 18:19:05 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 18:19:05 INFO - Using env: {'DISPLAY': ':0', 18:19:05 INFO - 'HOME': '/home/cltbld', 18:19:05 INFO - 'LANG': 'en_US.UTF-8', 18:19:05 INFO - 'LANGUAGE': 'en_US:en', 18:19:05 INFO - 'LOGNAME': 'cltbld', 18:19:05 INFO - 'MAIL': '/var/mail/cltbld', 18:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:05 INFO - 'MOZ_NO_REMOTE': '1', 18:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:05 INFO - 'NO_EM_RESTART': '1', 18:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:05 INFO - 'PWD': '/builds/slave/test', 18:19:05 INFO - 'SHELL': '/bin/bash', 18:19:05 INFO - 'SHLVL': '1', 18:19:05 INFO - 'TERM': 'linux', 18:19:05 INFO - 'TMOUT': '86400', 18:19:05 INFO - 'USER': 'cltbld', 18:19:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:05 INFO - '_': '/tools/buildbot/bin/python'} 18:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 INFO - Cleaning up... 18:19:05 INFO - Return code: 0 18:19:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, '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': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', '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 18:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:19:05 INFO - Using env: {'DISPLAY': ':0', 18:19:05 INFO - 'HOME': '/home/cltbld', 18:19:05 INFO - 'LANG': 'en_US.UTF-8', 18:19:05 INFO - 'LANGUAGE': 'en_US:en', 18:19:05 INFO - 'LOGNAME': 'cltbld', 18:19:05 INFO - 'MAIL': '/var/mail/cltbld', 18:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:05 INFO - 'MOZ_NO_REMOTE': '1', 18:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:05 INFO - 'NO_EM_RESTART': '1', 18:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:05 INFO - 'PWD': '/builds/slave/test', 18:19:05 INFO - 'SHELL': '/bin/bash', 18:19:05 INFO - 'SHLVL': '1', 18:19:05 INFO - 'TERM': 'linux', 18:19:05 INFO - 'TMOUT': '86400', 18:19:05 INFO - 'USER': 'cltbld', 18:19:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:05 INFO - '_': '/tools/buildbot/bin/python'} 18:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:19:05 INFO - Cleaning up... 18:19:05 INFO - Return code: 0 18:19:05 INFO - Running post-action listener: _resource_record_post_action 18:19:05 INFO - Running post-action listener: _start_resource_monitoring 18:19:05 INFO - Starting resource monitoring. 18:19:05 INFO - ##### 18:19:05 INFO - ##### Finished create-virtualenv step (success) 18:19:05 INFO - ##### 18:19:05 INFO - ##### 18:19:05 INFO - ##### Running install step. 18:19:05 INFO - ##### 18:19:05 INFO - Running pre-action listener: _resource_record_pre_action 18:19:05 INFO - Running main action method: install 18:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:05 INFO - Reading from file tmpfile_stdout 18:19:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:05 INFO - Reading from file tmpfile_stdout 18:19:05 INFO - Output received: 18:19:05 INFO - Usage: mozinstall [options] installer 18:19:05 INFO - Options: 18:19:05 INFO - -h, --help show this help message and exit 18:19:05 INFO - -d DEST, --destination=DEST 18:19:05 INFO - Directory to install application into. [default: 18:19:05 INFO - "/builds/slave/test"] 18:19:05 INFO - --app=APP Application being installed. [default: firefox] 18:19:05 INFO - mkdir: /builds/slave/test/build/application 18:19:05 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'] 18:19:05 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 18:19:22 INFO - Reading from file tmpfile_stdout 18:19:22 INFO - Output received: 18:19:22 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:22 INFO - Running post-action listener: _resource_record_post_action 18:19:22 INFO - ##### 18:19:22 INFO - ##### Finished install step (success) 18:19:22 INFO - ##### 18:19:22 INFO - ##### 18:19:22 INFO - ##### Running run-tests step. 18:19:22 INFO - ##### 18:19:22 INFO - Running pre-action listener: _resource_record_pre_action 18:19:22 INFO - Running main action method: run_tests 18:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:22 INFO - Python 2.7.3 18:19:22 INFO - Return code: 0 18:19:22 INFO - grabbing minidump binary from tooltool 18:19: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')]} 18:19:22 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 0x14eb3b0>, '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 0x14ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ec740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:22 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 18:19:22 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 18:19:22 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 18:19:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:22 INFO - Return code: 0 18:19:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:22 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/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 18:19:22 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/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 18:19:22 INFO - Using env: {'DISPLAY': ':0', 18:19:22 INFO - 'HOME': '/home/cltbld', 18:19:22 INFO - 'LANG': 'en_US.UTF-8', 18:19:22 INFO - 'LANGUAGE': 'en_US:en', 18:19:22 INFO - 'LOGNAME': 'cltbld', 18:19:22 INFO - 'MAIL': '/var/mail/cltbld', 18:19:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:22 INFO - 'MOZ_NO_REMOTE': '1', 18:19:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:22 INFO - 'NO_EM_RESTART': '1', 18:19:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:22 INFO - 'PWD': '/builds/slave/test', 18:19:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:22 INFO - 'SHELL': '/bin/bash', 18:19:22 INFO - 'SHLVL': '1', 18:19:22 INFO - 'TERM': 'linux', 18:19:22 INFO - 'TMOUT': '86400', 18:19:22 INFO - 'USER': 'cltbld', 18:19:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492', 18:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:22 INFO - '_': '/tools/buildbot/bin/python'} 18:19:22 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/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 18:19:22 INFO - mozversion application_buildid: 20160706173323 18:19:22 INFO - mozversion application_changeset: df9ad1cf01d7b32b051931f04629b696a7f9b98a 18:19:22 INFO - mozversion application_display_name: Nightly 18:19:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:22 INFO - mozversion application_name: Firefox 18:19:22 INFO - mozversion application_remotingname: firefox 18:19:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:19:22 INFO - mozversion application_vendor: Mozilla 18:19:22 INFO - mozversion application_version: 50.0a1 18:19:22 INFO - mozversion platform_buildid: 20160706173323 18:19:22 INFO - mozversion platform_changeset: df9ad1cf01d7b32b051931f04629b696a7f9b98a 18:19:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:19:22 INFO - mozversion platform_version: 50.0a1 18:19:22 INFO - using testdate: 1467854362 18:19:22 INFO - actual date: 1467854362 18:19:22 INFO - starting webserver on 'localhost:39434' 18:19:22 INFO - SUITE-START | Running 2 tests 18:19:22 INFO - TEST-START | dromaeo_css 18:19:22 INFO - operating with platform_type : linux_ 18:19:22 INFO - Initialising browser for dromaeo_css test... 18:19:22 INFO - TEST-INFO | started process 7882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy7gTYd/profile http://localhost:39434/getInfo.html) 18:19:26 INFO - PROCESS | 7882 | __metrics Screen width/height:1600/1200 18:19:26 INFO - PROCESS | 7882 | colorDepth:24 18:19:26 INFO - PROCESS | 7882 | Browser inner width/height: 1024/697 18:19:26 INFO - PROCESS | 7882 | __metrics 18:19:27 INFO - PROCESS | 7882 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:28 INFO - PROCESS | 7882 | console.error: PushService: 18:19:28 INFO - PROCESS | 7882 | stateChangeProcessEnqueue: Error transitioning state 18:19:28 INFO - PROCESS | 7882 | UnknownError 18:19:28 INFO - TEST-INFO | 7882: exit 0 18:19:28 INFO - Browser initialized. 18:19:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:28 INFO - TEST-INFO | started process 7963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy7gTYd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:40 INFO - PROCESS | 7963 | RSS: Main: 159494144 18:19:40 INFO - PROCESS | 7963 | 18:20:31 INFO - PROCESS | 7963 | 1467854431662 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] 18:22:44 INFO - PROCESS | 7963 | Cycle 1(1): loaded http://localhost:39434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39434/tests/dromaeo/cssquery-ext.html) 18:22:45 INFO - PROCESS | 7963 | RSS: Main: 251842560 18:22:45 INFO - PROCESS | 7963 | 18:25:48 INFO - PROCESS | 7963 | Cycle 1(1): loaded http://localhost:39434/tests/dromaeo/cssquery-ext.html (next: http://localhost:39434/tests/dromaeo/cssquery-jquery.html) 18:25:49 INFO - PROCESS | 7963 | RSS: Main: 247451648 18:25:49 INFO - PROCESS | 7963 | 18:28:51 INFO - PROCESS | 7963 | Cycle 1(1): loaded http://localhost:39434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39434/tests/dromaeo/cssquery-mootools.html) 18:28:51 INFO - PROCESS | 7963 | RSS: Main: 249532416 18:28:51 INFO - PROCESS | 7963 | 18:31:54 INFO - PROCESS | 7963 | Cycle 1(1): loaded http://localhost:39434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39434/tests/dromaeo/cssquery-prototype.html) 18:31:54 INFO - PROCESS | 7963 | RSS: Main: 244588544 18:31:54 INFO - PROCESS | 7963 | 18:34:57 INFO - PROCESS | 7963 | Cycle 1(1): loaded http://localhost:39434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39434/tests/dromaeo/cssquery-yui.html) 18:34:58 INFO - PROCESS | 7963 | RSS: Main: 231698432 18:34:58 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | Cycle 1(1): loaded http://localhost:39434/tests/dromaeo/cssquery-yui.html (next: http://localhost:39434/tests/dromaeo/cssquery-dojo.html) 18:38:01 INFO - PROCESS | 7963 | RSS: Main: 298049536 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | __start_tp_report 18:38:01 INFO - PROCESS | 7963 | _x_x_mozilla_page_load 18:38:01 INFO - PROCESS | 7963 | _x_x_mozilla_page_load_details 18:38:01 INFO - PROCESS | 7963 | |i|pagename|runs| 18:38:01 INFO - PROCESS | 7963 | |0;dojo.html;2614.0981361430304;2630.1977896741487;2656.1500319897636;2669.666291713536;2675.8929642814287;4654.441467023962;4715.386999690039;4717.929231061528;4748.738819364938;4786.353842231302;4723.102610504002;4769.785359658815;4778.378810754597;4786.952130478694;4803.159447096753;4155.958440415602;4304.677149213806;4366.104948485553;4394;4550.203714349992;4459.777011149446;4487.237169681162;4507.909841803178;4518.638508919295;4544.341070544769;4261.4460120184485;4289.2922667759785;4310.396544483775;4346.891327716832;4350.195213885441;4319.114581510814;4320.287152619814;4342.435483387139;4389.122175564899;4427.048184640285;4359.237133501656;4360.258756011485;4380.0582874682095;4403.669724770623;4404.66964977628;4618.953810461886;4650.534946505356;4709.081729062834;4782.497837727024;4813.302071199656;5073.137566613685;5159.380874295109;5172.715500647463;5187.792488300463;5190.2214667800135;5187.403448603422;5203.869903252411;5206.635535512478;5216;5216.8695782605355;4686;4691.249400095969;4715.882102947385;4796.832110876103;4845.830395936196;5192.9740351298005;5195.610329225323;5199.2201169824075;5248.239005344204;5249.711265880337;4989.426215985136;5027.296178535008;5037.722925239073;5039.899202016012;5047.091523525801;4981.825636102792;5059.443461219263;5065.822696205689;5102.336696229467;5103.744812759347;5017.54842064216;5037.0681423936685;5042.142835717937;5066.569341606005;5124.948750512447;5057.645964782503;5062.240663900371;5065.442801291855;5067.037262920034;5071.518205770446;4154.626083652486;4185.162967406531;4185.727927684691;4231;4237.427947227085;3733.272011957642;3737.6822970047306;3755.962440375616;3775.0562359410146;3777.433384992273;4372.759498227628;4386.473623165177;4400.537943515948;4437.689361744647;4443;5159.58723302135;5160.251763494347;5163.096458119814;5164.04465173944;5212.452692467312;4292.463442069741;4371.278739008092;4433.113377324548;4442.20040392726;4487.910241795146;4514.029483661028;4524.8416305429155;4539.001419687664;4572.565606267399;4576.084783043405;4793.424789025339;4849.854504364875;4851.490593487703;4853.95146048542;4899.461059283547;5003.449620541664;5036.722980236123;5102.770375333193;5126.307948426915;5136.1268584340005;4859.562639362474;4864.221724524059;4884.65807393479;4886.120498310338;4934.062528119646;5086.135356989246;5090.134677104975;5094.770735316845;5098.923516147335;5149.0474262261605;4970.3290055842;5077.720725360141;5121.1550094234035;5153.098207813692;5177.378714554127;4959.380077490314;4962.280469331855;4973.104841128632;4973.477784832685;5012.924806127984;4945.67853089548;4980.477049909852;4983.07813054586;4986.975065124796;5021.196608542616;4712.670113092187;4779.689320194177;4812.230043193213;4823.9517604824905;4929.531694489161;4918.975405122951;4922.089413458521;4941.589889849515;4945.505449455026;4975.5522003019905;4832.081904438145;4843.660943733905;4847.224444088929;4850.393700787402;4891.657583969088 18:38:01 INFO - PROCESS | 7963 | |1;ext.html;577.1717585265145;584.3134317177315;584.6901142394532;586.7037146241145;590.8759160576279;27172;43968.34047489286;45899.31151032733;45905.540944590546;45936.3109553357;41249.38125928114;41506.16987660245;41678.16643667125;41729;41771.37342939851;7511.774646760578;7771.650275737577;7917.524948503079;7925.247101525375;7927.246911543394;7484.288992545699;7745.845083098335;7750.651220695082;9929.702108936743;10207.081362677358;10249.948750256239;10282.537285822156;10300.484975751182;10300.948495257551;10316.845247321258;10072.294939354248;10096;10159.949200254025;10175.389476631426;10177.033181847713;7475.9252407476315;9877.654282100164;10215.23385746072;10221.591136354537;10540.051395374454;39485.60514394848;39899.40150897739;39910.80044599788;40047.19905601872;40166;2880.5967164596973;3081.3683194944983;3171.39743448744;3298.686624770643;3501.3172431375892;29552;29640.8517957411;29738.10785676433;29996.700032999608;30133.246668833235;3221.903342899717;3258.5275135105276;3287.161773747703;3350.0954742219465;3402.183475965775;258076;259236;259388;260025.69987150133;261316;31427.214319641735;32483.18792030218;54962.72518637381;55433.44566554364;55487.445125549035;33554;33878.830605846815;33888.66111338855;33909.830450847585;33936;13464.865351346558;13672.179669219879;13672.453101876012;13674;13690.178589284675;9573.377730447499;11512.827307590393;11577.305361678325;11583.189176757545;11601.07191424684;7684.884726729104;7875.133735289113;7908.130105688369;7985.241402066795;8050.798730031796;3069.6930306969125;3085.5371694245596;3090.8918187863765;3133.248020475115;3143.6699146589735;856.7087190355309;894.141624040928;910.0899100899101;919.103873723128;922.6678395777515;28751.42497150087;29136.562951555745;29208.415831683247;29454.705452945625;29558.852205738833;989.5003023473244;991.5785791038779;1005.0401866217744;1005.8692369991854;1030.3663247103127;14999.925000374928;15369.615759606098;15491.380344786083;15806.762898556532;15828.208589570475;372554;387179;387609;387703;389460;50671.49328506668;50973.490265097615;51186.232206516936;51219.23171152436;51300.23049654258;1088.1349327284986;1165.1261553834624;1175.1832476428972;1206.288289908958;1213.04775751035;25938.610920835825;29885.402291954473;29974.550381744728;30543.694563054087;30590.235244119074;43297;43334.78332608317;43708.78145609252;43832.78083609562;43902.560974389846;289107;289577;290262;290802;291804;22441.32676019722;24881.62677559802;25368;25535.616965745157;25699.614505782803;42902.35646465243;43168.56831431771;43500.564994349654;44151.77924110359;44520;36601.26797464089;37345.43981840329;37665;37896.242075158894;38057.80971095127;36098.4585231227;36458.8177059113;36499.81750091232;36530.452043219906;37488.25023499569;35652.28695426129;36464.08839778921;36661.81669091638;37096.814515927246;37317.81341093277;32329.24098216364;33098.33803323872;34863;34884.65115348814;37516.741901880705;25752.871235644452;26059.869700651376;26400.603990940537;26577.734222657527;26788 18:38:01 INFO - PROCESS | 7963 | |2;jquery.html;373.301925399503;376.4240711711082;378.31902575364336;384.85183204466273;397.39794211769174;16414.261358238877;17115.82884171158;17420.128993550305;17903;17907.82092179078;10690.572377104907;10926.562937482511;10966.835497467544;11000.779984400308;11008.944955275212;4291.733938488153;4608.308753686941;5382.784688612451;5403.756830942617;5414.214938833867;5175.741212939338;5201.713905735183;5214.947850521484;5228.712420816853;5245.082110630643;5090.974545127269;5193.376794784613;5294.311739473863;5300.496452836975;5300.575953923677;5285.68285902847;5287.101192797195;5293.550048245904;5302.469753024686;5302.6023048271345;4576.473705523841;4801.039792041605;4803.471618122004;4804.495527969548;4817.51824817519;21358.252461163785;21498.462538436663;21850.672239916414;22318.2188623399;22393;1710.9230084646222;1834.1562881074722;1856.5358660334916;1916.7316575679415;1975.5555000125;9616.374935629161;9926.652567160114;10054.195664346908;11016.779664406748;14357;1606.1246620591805;1685.6460143369907;1697.651981343834;1699.1164594410961;1716.9914150429292;52336;65223.99999999953;67104.32895671029;67676.32323676799;76259.23740762577;10180.847287290548;10396.948015260026;10531.894681053245;10581.41802200871;10592.788144237073;12635.810462843065;13019.609411717664;13801.51694690681;13857.722845543032;14278.714425711427;7024.508284420143;7102;7156.892646610305;7242;7285.817854553573;6527.118838956775;6553.377429144319;6694.330566943364;6712.026756120335;6746.730130794811;4395.7362558246605;4507.076049409863;4508.639308855284;4513.75174365413;4591.150637132141;1824.6077093424713;1875.315509838899;1910.1881700277604;1919.0884329943165;1931.2757715856553;748.5695724958061;839.7942504086416;840.7225615546855;860.3762272352494;901.2339511415375;17072.48782536526;17227.913860430617;17336.479905602853;17533.649327013387;17667.20497577612;823.880537322097;825.6986200036944;827.230675471805;859.5788063848669;915.496476937695;9710.17463515609;9903.504824758877;10013.399196048114;10022.949885250528;10199.643012494527;354694;374853;375737;376150;378387;77394;78234.6088269555;78878.60560697275;79021.20978790254;79460;894.9552522373855;904.5025236120108;911.7629416351664;922.1884741427501;928.7863791327898;15325;15898.284577193823;16104.597385065466;16169.116986555622;16326.428574999818;38071.2385752289;38470.23059538849;38621.80689096537;39166.80416597899;39651.405228922165;51338.74330628323;52217.7389113052;52230.47769522408;52472.21291680552;52498.73750631375;6923.169219693669;7076.964615176891;7938.920610794049;8033.5983200838555;8183.631736571988;11768.94115529417;12219.144659873724;12570.811437828257;12633;12739.936300318439;10610.310329828537;10764.946175269073;10830.67507974762;10949.562017519529;10962.725931851448;10539.525721342712;10908.945455272673;11057.778844423228;11082;11159.776804463703;10053.849192262269;10602.681919542427;10750.677479675622;10878.23852330361;10979.066779323846;6971.51199416036;7079.43364530826;7107.18267399235;7133.3936615388275;7429.777106686808;10318.742031449274;10488.790224195625;10544.947275263574;10615.575376985144;10682.786344272916 18:38:01 INFO - PROCESS | 7963 | |3;mootools.html;1240.7518496300743;1396.7834985577233;1443.3216388297499;1524.3216768538005;1753.5265478320853;6818.181818181819;7630.504017238875;7865.134835168141;7876.881846772289;7885.763427097189;7504.137024242214;7739.419543534229;7743.380529557636;7934.285914267714;7934.880976785353;1932.9613407731838;2168.219441001246;2212.889355532221;2269.807066399358;2272.738635056965;2272.5909336319455;2281.2129815213725;2283.7031185945802;2285.542891421714;2285.611446054175;2260.3106052653934;2260.954780904381;2296.0930432479163;2298.367948814073;2302.309307207831;1863.7018077107734;2081.3859911326044;2162.426956856434;2165.956680866374;2186.9015894284717;2217.401301648546;2233.475133343663;2237.7985981261763;2238.373255488466;2241.2155745489113;7978.361731061559;8028.839423211562;8029.156938521488;8031.1165771765645;8033.718819841336;4585.151746926829;4693.507181745936;4712.340272361872;4722.693024953402;4723.36234608327;2744.0395861448533;2824.350399408127;2894.3921776426973;2899.246195989058;2908.8400137992403;889.7642124836923;891.8038031633031;899.2131884600974;1603.8636715879163;1644.4984279794658;10916.126709863192;11140.498677559448;11150.386728729836;11158;11165.83251251232;4335.934960975588;4342.457192850894;4516.954830451654;4519.412476378116;4528.456585209796;9469.857952130724;9498.667546635834;9510;9530.332876698565;9536.475493847905;4895.241237608177;4897.461279259279;4900.681455705368;4902.828401005948;4904.215325547895;3767.585565587783;4251.511076226212;4380.299152135643;4391.07787364657;4470.6870519064005;3740.925181496355;3777.527809023872;3828.062124779447;3866.4200369944733;3883.3204189266767;1092.9125669946386;1142.5772464188137;1179.9587014454453;1182.8403165572538;1205.6376294786835;668.7024274198033;733.3070248615114;791.6912404162381;801.8115742800437;802.1577343789115;5066.594672426197;5293.338332708411;5332.253484512172;5457.099578569571;5577.330720313588;811.8944537210243;834.0491839303199;851.9105493923173;879.1779685993616;910.9089091090838;3180.475221588412;3365.242820365447;3387.6442973487924;3392.4741665041956;3410.5395771571016;9770.706878793648;9916.504174791231;9945.303828732063;10020.949895250624;10037.849432258521;9907.6624655672;9929.354591951644;9932.404055756677;9938.602455901682;9939.50302484873;7359.337659610661;7426.071741032371;7535.8116047098165;7554.169041405441;7589.620518974029;4770;4845.394325709286;4851.369321988119;4871.098846713369;4955.950440495549;9181.806365172484;9234.815303693755;9319.813603728024;9335.57989890443;9355.812883742423;9089.818203636023;9543.4751088688;9547.904520954702;9557.808843823224;9578.137967582672;6353.301136875032;6483.610983341015;6488.2538508072175;6489.7404103835315;6496.837579060561;7371.557706537625;7429.294217049372;7429.8142546436775;7445.553266804009;7445.9627701861145;5500.9174862377895;6461.19235095613;6589.505787065893;6858.417034552119;7028.683709232994;6822.624755638488;6912.827179320558;6934.583924964519;7006.894896576454;7110.32451917067;5965.940340596539;6064.969675151596;6109.11417844419;6110.2973158085615;6111.908321375272;4634.976825115853;4647.697899636512;4692.741899195577;4705.7411842349;4741.810327586858;4340.913181736284;4355.210662894622;4431.202383570988;4547.113312903952;4547.522510136388 18:38:01 INFO - PROCESS | 7963 | |4;prototype.html;294.8555207948106;299.89353779408304;304.74553747620735;306.32761089408757;306.3551224672065;4754.3819303490545;4805.711657300556;4844.442889067754;4850.587700045491;4853.999999999995;4526.343680166374;4612.86161415158;4643.837465688702;4676.532346765322;4775.90448191036;3675;3699.741018128732;3705.944410833826;3760.548734151892;3820.522434695663;3759.906002349936;3788.2802267569073;3800.4869342638804;3822.636849499293;3829.8276577554075;3694.242680250542;3775.377062784651;3785.3754130568423;3804.4293355996683;3809.409541521055;3788.3559794834805;3789.242151569697;3800.7339486235974;3805.7906815125157;3816.7709937403565;3354.245294808673;3355.1612096975755;3360.54632624595;3362.5796775403073;3379.7803142795638;4675.929861052087;4683.414573178353;4704.764761761899;4712.31671407644;4719.480857105716;4155.065110350177;4323.135372925428;4324.113556720865;4367.563243675607;4396.604305612478;5038.168702164138;5044.571211447032;5047.318611987408;5068.949310506885;5073.213651883927;3665.7617254878346;3699.9815000924823;3702.129999450127;3719.6466335698065;3727.347714150013;5159.845204643867;5286.497782710637;5294;5296.894062118775;5315.123004704258;3756.1173124315765;3762.492063571383;3766.6798322142927;3769.208466222069;3784;3818.6372294631965;3819.834950340173;3833.3674943633987;3837.597052309523;3838.961610383916;4326.156399502067;4356.455443069616;4358.847440339637;4363.6072753452345;4372.825086996548;4877.609791216694;4999.900001999939;5012.7718708916545;5021.924671129936;5045.571126454219;1307.4966138036925;1319.3798914510164;1321.5110409148485;1328.634625477982;1331.5872079655337;873.785922449004;904.2856143646445;930.1070971867083;939.3940908114228;940.83535381308;4391.758453285036;4399.12017596482;4421.11577684458;4426.734395936254;4431.423914891044;5097.617678674114;5103.081445339801;5111.591072714174;5124.333836601292;5134.614903882149;4288.649075541194;4433.312836510346;4435.290353543418;4442.355858400514;4451.821927122879;2707.3502359433596;2727.9863600682265;2731.4810186064983;2732.6584176977876;2737.3293543082073;4853.611711063107;4864.148773964542;4865.854024379274;4867.367242258484;4871.853844384604;5040.521150490697;5245.370555533361;5256.211568264791;5308.840734777886;5319.654222475527;4873.80504779812;4903.289023091632;4920.384951881087;4929.654924155275;4929.876753081202;5194.480551944926;5199.63602547818;5200.167973124282;5240.580753539632;5251.422343542284;4892.3884514435695;5156.865489592284;5167.483251674803;5174.7153906535505;5187.299714538489;4955.909699866023;4974.776135073858;4979.601631869369;4990.301357809837;5005.099082165245;3722.9069273268383;3746.4380342948775;3748.1566647505183;3757.981210093932;3762.5673047599876;5135.460776618551;5247.790088396574;5317.893642127213;5320.388155362183;5321.627486075938;5027.572656324253;5039.571636410946;5052.267421223975;5073.92389114171;5088.59291256706;5030.496950305087;5030.974845125751;5048.974755126201;5062.645614806928;5082.644214904921;4706.717596944194;4711.458182309078;4943.258511223202;4967.975160124176;5043.9747801260755;4949.752512374295;4954.126606568109;4960.900781984268;4979.800807967641;4986.650934434555;4835.2505361669;4940.481249468898;4977.576905963034;4993.375828021497;4994.800207991785 18:38:01 INFO - PROCESS | 7963 | |5;yui.html;664.4883439751392;674.4941294029475;684.9246582875884;704.69345834562;751.9735560959289;11553.133514986368;12026.579069732561;12045;12047.09646776493;12064.879351206486;11368.943155284232;11544.942275288611;11548.422578871045;11550.884491155086;11562.59530916418;627.6485168305741;760.8440269744717;765.3723946363983;777.4790890103644;778.3928535742102;766.9079710434728;767.1024900866;767.2021098058041;767.6929228308666;781.8514482248384;813.5078277642031;814.1370147643516;814.6252723747084;814.7881550796806;814.816666250095;649.7401039584204;793.7896457438783;805.2631841864745;806.9838603227932;810.3638643664724;591.8283697727654;592.1266132454638;592.2034863109154;592.2448877680948;593.3413910559276;11731.88268117325;11771.352575608338;11780;11780.352080635561;11784.175107742461;11556.768864622745;11564.53741850325;11839.585614503538;12055.698607534794;12066.336351500664;11151.944240278828;11230.438478076063;11346.886531134747;11548.53805847765;11721.94139029308;3736.6076561960876;3806.0484878780303;3828.8659896903755;3890.2414029264305;3926.823292951824;60212.096818547754;60880.391196087476;60895.39104608942;61717.69141154311;62075.689621552054;9327.533623318806;9911.603535858629;9963.053509916546;9995;10090.192784577217;15805.36778528869;15988.200589970687;16115.516534503984;16143;16164.353425862833;6212;6293.1504246927;6312.43188113072;6316.905246421307;6391.776287829904;3714.33142034431;3788.924221515554;3796.2217745362136;3808.504894363715;3860.2279544091293;2731.6039174319612;2825.6044153818484;2837.163036904118;2839.205022593677;2839.9148025559266;484.1623990496391;500.039923347167;512.0297037114647;512.1370490723143;513.3480479790719;448.82047181127155;470.097412967104;492.3845193508115;547.805529037194;605.2343785111836;7482.551046937092;7998.685802183411;8072.556009419421;8112.985876765404;8340.62467188978;475.5387274343881;546.2189069630388;552.7899398228648;564.9858753531113;593.1873333533088;3872.28362752886;3895.844166233319;4024.577419370924;4116.897077573085;4201.810918508674;79397;91875.54062229647;92390.14683751822;94474;94783;50438.74780626073;66239;68202;83190.58404708059;86168.56915715382;44908.3263751044;60731;61785.691071545254;63711.6814415925;72858.99999999894;8128.63421146038;8361.540115293717;8409.2431681149;8516.659333626585;8586.71240958417;31868.84065579657;44657.33014004857;44901;45002.77498612486;45512.54487455083;62890.339869411975;65179.674101629185;65679.67160164169;65916.67041664761;65956.34043659693;10565.841512377474;10946.616868409568;11001.284916480403;11191.832122518006;11292;12995.28525931083;13034.54379096765;13257.602271931857;13492.730145397234;14021.929890350482;11902.226355287225;12467.75064498723;12559.37203139821;12573.685657858627;12679.873201267868;11825.763484730429;11855.52577896909;12355.567555135887;12363.93818030904;12364;11544.249623774427;11683.824742628698;12024.939875300568;12445.502179912703;12450.319206906952;10097.596096156072;10225.43760093202;10311.07200351972;10467.738306542398;10584.259101862795;9832.164266037467;10179.592816287266;10264.127549158107;10300.896991029993;10315.793684126125 18:38:01 INFO - PROCESS | 7963 | __end_tp_report 18:38:01 INFO - PROCESS | 7963 | __start_cc_report 18:38:01 INFO - PROCESS | 7963 | _x_x_mozilla_cycle_collect,949 18:38:01 INFO - PROCESS | 7963 | __end_cc_report 18:38:01 INFO - PROCESS | 7963 | __startTimestamp1467855481913__endTimestamp 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | ------- Summary: start ------- 18:38:01 INFO - PROCESS | 7963 | Number of tests: 6 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | [#0] dojo.html Cycles:165 Average:4708.56 Median:4847.22 stddev:505.20 (10.4%) stddev-sans-first:479.29 18:38:01 INFO - PROCESS | 7963 | Values: 2614.1 2630.2 2656.2 2669.7 2675.9 4654.4 4715.4 4717.9 4748.7 4786.4 4723.1 4769.8 4778.4 4787.0 4803.2 4156.0 4304.7 4366.1 4394.0 4550.2 4459.8 4487.2 4507.9 4518.6 4544.3 4261.4 4289.3 4310.4 4346.9 4350.2 4319.1 4320.3 4342.4 4389.1 4427.0 4359.2 4360.3 4380.1 4403.7 4404.7 4619.0 4650.5 4709.1 4782.5 4813.3 5073.1 5159.4 5172.7 5187.8 5190.2 5187.4 5203.9 5206.6 5216.0 5216.9 4686.0 4691.2 4715.9 4796.8 4845.8 5193.0 5195.6 5199.2 5248.2 5249.7 4989.4 5027.3 5037.7 5039.9 5047.1 4981.8 5059.4 5065.8 5102.3 5103.7 5017.5 5037.1 5042.1 5066.6 5124.9 5057.6 5062.2 5065.4 5067.0 5071.5 4154.6 4185.2 4185.7 4231.0 4237.4 3733.3 3737.7 3756.0 3775.1 3777.4 4372.8 4386.5 4400.5 4437.7 4443.0 5159.6 5160.3 5163.1 5164.0 5212.5 4292.5 4371.3 4433.1 4442.2 4487.9 4514.0 4524.8 4539.0 4572.6 4576.1 4793.4 4849.9 4851.5 4854.0 4899.5 5003.4 5036.7 5102.8 5126.3 5136.1 4859.6 4864.2 4884.7 4886.1 4934.1 5086.1 5090.1 5094.8 5098.9 5149.0 4970.3 5077.7 5121.2 5153.1 5177.4 4959.4 4962.3 4973.1 4973.5 5012.9 4945.7 4980.5 4983.1 4987.0 5021.2 4712.7 4779.7 4812.2 4824.0 4929.5 4919.0 4922.1 4941.6 4945.5 4975.6 4832.1 4843.7 4847.2 4850.4 4891.7 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | [#1] ext.html Cycles:180 Average:46361.76 Median:33883.75 stddev:83181.44 (245.5%) stddev-sans-first:83343.75 18:38:01 INFO - PROCESS | 7963 | Values: 577.2 584.3 584.7 586.7 590.9 27172.0 43968.3 45899.3 45905.5 45936.3 41249.4 41506.2 41678.2 41729.0 41771.4 7511.8 7771.7 7917.5 7925.2 7927.2 7484.3 7745.8 7750.7 9929.7 10207.1 10249.9 10282.5 10300.5 10300.9 10316.8 10072.3 10096.0 10159.9 10175.4 10177.0 7475.9 9877.7 10215.2 10221.6 10540.1 39485.6 39899.4 39910.8 40047.2 40166.0 2880.6 3081.4 3171.4 3298.7 3501.3 29552.0 29640.9 29738.1 29996.7 30133.2 3221.9 3258.5 3287.2 3350.1 3402.2 258076.0 259236.0 259388.0 260025.7 261316.0 31427.2 32483.2 54962.7 55433.4 55487.4 33554.0 33878.8 33888.7 33909.8 33936.0 13464.9 13672.2 13672.5 13674.0 13690.2 9573.4 11512.8 11577.3 11583.2 11601.1 7684.9 7875.1 7908.1 7985.2 8050.8 3069.7 3085.5 3090.9 3133.2 3143.7 856.7 894.1 910.1 919.1 922.7 28751.4 29136.6 29208.4 29454.7 29558.9 989.5 991.6 1005.0 1005.9 1030.4 14999.9 15369.6 15491.4 15806.8 15828.2 372554.0 387179.0 387609.0 387703.0 389460.0 50671.5 50973.5 51186.2 51219.2 51300.2 1088.1 1165.1 1175.2 1206.3 1213.0 25938.6 29885.4 29974.6 30543.7 30590.2 43297.0 43334.8 43708.8 43832.8 43902.6 289107.0 289577.0 290262.0 290802.0 291804.0 22441.3 24881.6 25368.0 25535.6 25699.6 42902.4 43168.6 43500.6 44151.8 44520.0 36601.3 37345.4 37665.0 37896.2 38057.8 36098.5 36458.8 36499.8 36530.5 37488.3 35652.3 36464.1 36661.8 37096.8 37317.8 32329.2 33098.3 34863.0 34884.7 37516.7 25752.9 26059.9 26400.6 26577.7 26788.0 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | [#2] jquery.html Cycles:180 Average:23834.05 Median:19427.54 stddev:61571.75 (316.9%) stddev-sans-first:61719.27 18:38:01 INFO - PROCESS | 7963 | Values: 373.3 376.4 378.3 384.9 397.4 16414.3 17115.8 17420.1 17903.0 17907.8 10690.6 10926.6 10966.8 11000.8 11008.9 4291.7 4608.3 5382.8 5403.8 5414.2 5175.7 5201.7 5214.9 5228.7 5245.1 5091.0 5193.4 5294.3 5300.5 5300.6 5285.7 5287.1 5293.6 5302.5 5302.6 4576.5 4801.0 4803.5 4804.5 4817.5 21358.3 21498.5 21850.7 22318.2 22393.0 1710.9 1834.2 1856.5 1916.7 1975.6 9616.4 9926.7 10054.2 11016.8 14357.0 1606.1 1685.6 1697.7 1699.1 1717.0 52336.0 65224.0 67104.3 67676.3 76259.2 10180.8 10396.9 10531.9 10581.4 10592.8 12635.8 13019.6 13801.5 13857.7 14278.7 7024.5 7102.0 7156.9 7242.0 7285.8 6527.1 6553.4 6694.3 6712.0 6746.7 4395.7 4507.1 4508.6 4513.8 4591.2 1824.6 1875.3 1910.2 1919.1 1931.3 748.6 839.8 840.7 860.4 901.2 17072.5 17227.9 17336.5 17533.6 17667.2 823.9 825.7 827.2 859.6 915.5 9710.2 9903.5 10013.4 10022.9 10199.6 354694.0 374853.0 375737.0 376150.0 378387.0 77394.0 78234.6 78878.6 79021.2 79460.0 895.0 904.5 911.8 922.2 928.8 15325.0 15898.3 16104.6 16169.1 16326.4 38071.2 38470.2 38621.8 39166.8 39651.4 51338.7 52217.7 52230.5 52472.2 52498.7 6923.2 7077.0 7938.9 8033.6 8183.6 11768.9 12219.1 12570.8 12633.0 12739.9 10610.3 10764.9 10830.7 10949.6 10962.7 10539.5 10908.9 11057.8 11082.0 11159.8 10053.8 10602.7 10750.7 10878.2 10979.1 6971.5 7079.4 7107.2 7133.4 7429.8 10318.7 10488.8 10544.9 10615.6 10682.8 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | [#3] mootools.html Cycles:180 Average:5213.23 Median:4901.75 stddev:2965.86 (60.5%) stddev-sans-first:2959.15 18:38:01 INFO - PROCESS | 7963 | Values: 1240.8 1396.8 1443.3 1524.3 1753.5 6818.2 7630.5 7865.1 7876.9 7885.8 7504.1 7739.4 7743.4 7934.3 7934.9 1933.0 2168.2 2212.9 2269.8 2272.7 2272.6 2281.2 2283.7 2285.5 2285.6 2260.3 2261.0 2296.1 2298.4 2302.3 1863.7 2081.4 2162.4 2166.0 2186.9 2217.4 2233.5 2237.8 2238.4 2241.2 7978.4 8028.8 8029.2 8031.1 8033.7 4585.2 4693.5 4712.3 4722.7 4723.4 2744.0 2824.4 2894.4 2899.2 2908.8 889.8 891.8 899.2 1603.9 1644.5 10916.1 11140.5 11150.4 11158.0 11165.8 4335.9 4342.5 4517.0 4519.4 4528.5 9469.9 9498.7 9510.0 9530.3 9536.5 4895.2 4897.5 4900.7 4902.8 4904.2 3767.6 4251.5 4380.3 4391.1 4470.7 3740.9 3777.5 3828.1 3866.4 3883.3 1092.9 1142.6 1180.0 1182.8 1205.6 668.7 733.3 791.7 801.8 802.2 5066.6 5293.3 5332.3 5457.1 5577.3 811.9 834.0 851.9 879.2 910.9 3180.5 3365.2 3387.6 3392.5 3410.5 9770.7 9916.5 9945.3 10020.9 10037.8 9907.7 9929.4 9932.4 9938.6 9939.5 7359.3 7426.1 7535.8 7554.2 7589.6 4770.0 4845.4 4851.4 4871.1 4956.0 9181.8 9234.8 9319.8 9335.6 9355.8 9089.8 9543.5 9547.9 9557.8 9578.1 6353.3 6483.6 6488.3 6489.7 6496.8 7371.6 7429.3 7429.8 7445.6 7446.0 5500.9 6461.2 6589.5 6858.4 7028.7 6822.6 6912.8 6934.6 7006.9 7110.3 5965.9 6065.0 6109.1 6110.3 6111.9 4635.0 4647.7 4692.7 4705.7 4741.8 4340.9 4355.2 4431.2 4547.1 4547.5 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | [#4] prototype.html Cycles:180 Average:4204.66 Median:4736.93 stddev:1201.78 (25.4%) stddev-sans-first:1168.77 18:38:01 INFO - PROCESS | 7963 | Values: 294.9 299.9 304.7 306.3 306.4 4754.4 4805.7 4844.4 4850.6 4854.0 4526.3 4612.9 4643.8 4676.5 4775.9 3675.0 3699.7 3705.9 3760.5 3820.5 3759.9 3788.3 3800.5 3822.6 3829.8 3694.2 3775.4 3785.4 3804.4 3809.4 3788.4 3789.2 3800.7 3805.8 3816.8 3354.2 3355.2 3360.5 3362.6 3379.8 4675.9 4683.4 4704.8 4712.3 4719.5 4155.1 4323.1 4324.1 4367.6 4396.6 5038.2 5044.6 5047.3 5068.9 5073.2 3665.8 3700.0 3702.1 3719.6 3727.3 5159.8 5286.5 5294.0 5296.9 5315.1 3756.1 3762.5 3766.7 3769.2 3784.0 3818.6 3819.8 3833.4 3837.6 3839.0 4326.2 4356.5 4358.8 4363.6 4372.8 4877.6 4999.9 5012.8 5021.9 5045.6 1307.5 1319.4 1321.5 1328.6 1331.6 873.8 904.3 930.1 939.4 940.8 4391.8 4399.1 4421.1 4426.7 4431.4 5097.6 5103.1 5111.6 5124.3 5134.6 4288.6 4433.3 4435.3 4442.4 4451.8 2707.4 2728.0 2731.5 2732.7 2737.3 4853.6 4864.1 4865.9 4867.4 4871.9 5040.5 5245.4 5256.2 5308.8 5319.7 4873.8 4903.3 4920.4 4929.7 4929.9 5194.5 5199.6 5200.2 5240.6 5251.4 4892.4 5156.9 5167.5 5174.7 5187.3 4955.9 4974.8 4979.6 4990.3 5005.1 3722.9 3746.4 3748.2 3758.0 3762.6 5135.5 5247.8 5317.9 5320.4 5321.6 5027.6 5039.6 5052.3 5073.9 5088.6 5030.5 5031.0 5049.0 5062.6 5082.6 4706.7 4711.5 4943.3 4968.0 5044.0 4949.8 4954.1 4960.9 4979.8 4986.7 4835.3 4940.5 4977.6 4993.4 4994.8 18:38:01 INFO - PROCESS | 7963 | 18:38:01 INFO - PROCESS | 7963 | [#5] yui.html Cycles:180 Average:16663.11 Median:45257.66 stddev:23183.29 (51.2%) stddev-sans-first:23217.20 18:38:01 INFO - PROCESS | 7963 | Values: 664.5 674.5 684.9 704.7 752.0 11553.1 12026.6 12045.0 12047.1 12064.9 11368.9 11544.9 11548.4 11550.9 11562.6 627.6 760.8 765.4 777.5 778.4 766.9 767.1 767.2 767.7 781.9 813.5 814.1 814.6 814.8 814.8 649.7 793.8 805.3 807.0 810.4 591.8 592.1 592.2 592.2 593.3 11731.9 11771.4 11780.0 11780.4 11784.2 11556.8 11564.5 11839.6 12055.7 12066.3 11151.9 11230.4 11346.9 11548.5 11721.9 3736.6 3806.0 3828.9 3890.2 3926.8 60212.1 60880.4 60895.4 61717.7 62075.7 9327.5 9911.6 9963.1 9995.0 10090.2 15805.4 15988.2 16115.5 16143.0 16164.4 6212.0 6293.2 6312.4 6316.9 6391.8 3714.3 3788.9 3796.2 3808.5 3860.2 2731.6 2825.6 2837.2 2839.2 2839.9 484.2 500.0 512.0 512.1 513.3 448.8 470.1 492.4 547.8 605.2 7482.6 7998.7 8072.6 8113.0 8340.6 475.5 546.2 552.8 565.0 593.2 3872.3 3895.8 4024.6 4116.9 4201.8 79397.0 91875.5 92390.1 94474.0 94783.0 50438.7 66239.0 68202.0 83190.6 86168.6 44908.3 60731.0 61785.7 63711.7 72859.0 8128.6 8361.5 8409.2 8516.7 8586.7 31868.8 44657.3 44901.0 45002.8 45512.5 62890.3 65179.7 65679.7 65916.7 65956.3 10565.8 10946.6 11001.3 11191.8 11292.0 12995.3 13034.5 13257.6 13492.7 14021.9 11902.2 12467.8 12559.4 12573.7 12679.9 11825.8 11855.5 12355.6 12363.9 12364.0 11544.2 11683.8 12024.9 12445.5 12450.3 10097.6 10225.4 10311.1 10467.7 10584.3 9832.2 10179.6 10264.1 10300.9 10315.8 18:38:01 INFO - PROCESS | 7963 | -------- Summary: end -------- 18:38:01 INFO - PROCESS | 7963 | 18:38:02 INFO - TEST-INFO | 7963: exit 0 18:38:02 INFO - TEST-OK | dromaeo_css | took 1120200ms 18:38:02 INFO - TEST-START | kraken 18:38:02 INFO - operating with platform_type : linux_ 18:38:02 INFO - Initialising browser for kraken test... 18:38:02 INFO - TEST-INFO | started process 8146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nnnWW/profile http://localhost:39434/getInfo.html) 18:38:07 INFO - PROCESS | 8146 | __metrics Screen width/height:1600/1200 18:38:07 INFO - PROCESS | 8146 | colorDepth:24 18:38:07 INFO - PROCESS | 8146 | Browser inner width/height: 1024/697 18:38:07 INFO - PROCESS | 8146 | __metrics 18:38:08 INFO - PROCESS | 8146 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:08 INFO - TEST-INFO | 8146: exit 0 18:38:08 INFO - Browser initialized. 18:38:08 INFO - Running cycle 1/1 for kraken test... 18:38:08 INFO - TEST-INFO | started process 8228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nnnWW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:20 INFO - PROCESS | 8228 | RSS: Main: 159272960 18:38:20 INFO - PROCESS | 8228 | 18:38:23 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39434/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:24 INFO - PROCESS | 8228 | RSS: Main: 217133056 18:38:24 INFO - PROCESS | 8228 | 18:38:27 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39434/tests/kraken/driver.html?testName=audio-dft) 18:38:27 INFO - PROCESS | 8228 | RSS: Main: 204472320 18:38:27 INFO - PROCESS | 8228 | 18:38:31 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39434/tests/kraken/driver.html?testName=audio-fft) 18:38:31 INFO - PROCESS | 8228 | RSS: Main: 270831616 18:38:31 INFO - PROCESS | 8228 | 18:38:33 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39434/tests/kraken/driver.html?testName=audio-oscillator) 18:38:34 INFO - PROCESS | 8228 | RSS: Main: 182693888 18:38:34 INFO - PROCESS | 8228 | 18:38:36 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:37 INFO - PROCESS | 8228 | RSS: Main: 186548224 18:38:37 INFO - PROCESS | 8228 | 18:38:40 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39434/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:41 INFO - PROCESS | 8228 | RSS: Main: 222515200 18:38:41 INFO - PROCESS | 8228 | 18:38:44 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39434/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:45 INFO - PROCESS | 8228 | RSS: Main: 218255360 18:38:45 INFO - PROCESS | 8228 | 18:38:47 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39434/tests/kraken/driver.html?testName=json-parse-financial) 18:38:48 INFO - PROCESS | 8228 | RSS: Main: 221159424 18:38:48 INFO - PROCESS | 8228 | 18:38:50 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:50 INFO - PROCESS | 8228 | RSS: Main: 207974400 18:38:50 INFO - PROCESS | 8228 | 18:38:52 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:53 INFO - PROCESS | 8228 | RSS: Main: 212643840 18:38:53 INFO - PROCESS | 8228 | 18:38:55 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:56 INFO - PROCESS | 8228 | RSS: Main: 211701760 18:38:56 INFO - PROCESS | 8228 | 18:38:59 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:59 INFO - PROCESS | 8228 | RSS: Main: 224301056 18:38:59 INFO - PROCESS | 8228 | 18:39:02 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:03 INFO - PROCESS | 8228 | RSS: Main: 224555008 18:39:03 INFO - PROCESS | 8228 | 18:39:04 INFO - PROCESS | 8228 | Cycle 1(1): loaded http://localhost:39434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39434/tests/kraken/driver.html?testName=ai-astar) 18:39:05 INFO - PROCESS | 8228 | RSS: Main: 267157504 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | __start_tp_report 18:39:05 INFO - PROCESS | 8228 | _x_x_mozilla_page_load 18:39:05 INFO - PROCESS | 8228 | _x_x_mozilla_page_load_details 18:39:05 INFO - PROCESS | 8228 | |i|pagename|runs| 18:39:05 INFO - PROCESS | 8228 | |0;ai-astar;103;114;112;111;112;111;112;110;113;112 18:39:05 INFO - PROCESS | 8228 | |1;audio-beat-detection;150;123;123;176;123;123;148;122;167;126 18:39:05 INFO - PROCESS | 8228 | |2;audio-dft;165;162;161;163;164;162;162;163;162;162 18:39:05 INFO - PROCESS | 8228 | |3;audio-fft;75;76;76;132;76;77;75;74;113;76 18:39:05 INFO - PROCESS | 8228 | |4;audio-oscillator;85;87;119;86;86;86;114;85;85;126 18:39:05 INFO - PROCESS | 8228 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 18:39:05 INFO - PROCESS | 8228 | |6;imaging-darkroom;147;147;146;146;146;146;147;147;146;146 18:39:05 INFO - PROCESS | 8228 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 18:39:05 INFO - PROCESS | 8228 | |8;json-parse-financial;64;62;63;64;63;63;62;64;62;61 18:39:05 INFO - PROCESS | 8228 | |9;json-stringify-tinderbox;65;74;65;65;65;65;65;65;65;65 18:39:05 INFO - PROCESS | 8228 | |10;stanford-crypto-aes;79;79;78;79;82;78;78;86;78;86 18:39:05 INFO - PROCESS | 8228 | |11;stanford-crypto-ccm;138;130;128;128;129;128;137;131;211;130 18:39:05 INFO - PROCESS | 8228 | |12;stanford-crypto-pbkdf2;167;167;164;163;164;170;163;166;163;163 18:39:05 INFO - PROCESS | 8228 | |13;stanford-crypto-sha256-iterative;72;69;66;66;65;66;66;66;67;67 18:39:05 INFO - PROCESS | 8228 | __end_tp_report 18:39:05 INFO - PROCESS | 8228 | __start_cc_report 18:39:05 INFO - PROCESS | 8228 | _x_x_mozilla_cycle_collect,1896 18:39:05 INFO - PROCESS | 8228 | __end_cc_report 18:39:05 INFO - PROCESS | 8228 | __startTimestamp1467855545118__endTimestamp 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | ------- Summary: start ------- 18:39:05 INFO - PROCESS | 8228 | Number of tests: 14 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.02 (2.7%) stddev-sans-first:1.17 18:39:05 INFO - PROCESS | 8228 | Values: 103.0 114.0 112.0 111.0 112.0 111.0 112.0 110.0 113.0 112.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:137.00 stddev:20.63 (15.1%) stddev-sans-first:21.42 18:39:05 INFO - PROCESS | 8228 | Values: 150.0 123.0 123.0 176.0 123.0 123.0 148.0 122.0 167.0 126.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.17 (0.7%) stddev-sans-first:0.87 18:39:05 INFO - PROCESS | 8228 | Values: 165.0 162.0 161.0 163.0 164.0 162.0 162.0 163.0 162.0 162.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#3] audio-fft Cycles:10 Average:85.00 Median:76.00 stddev:20.28 (26.7%) stddev-sans-first:21.19 18:39:05 INFO - PROCESS | 8228 | Values: 75.0 76.0 76.0 132.0 76.0 77.0 75.0 74.0 113.0 76.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.50 stddev:16.66 (19.5%) stddev-sans-first:17.19 18:39:05 INFO - PROCESS | 8228 | Values: 85.0 87.0 119.0 86.0 86.0 86.0 114.0 85.0 85.0 126.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:39:05 INFO - PROCESS | 8228 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 18:39:05 INFO - PROCESS | 8228 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:39:05 INFO - PROCESS | 8228 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 18:39:05 INFO - PROCESS | 8228 | Values: 64.0 62.0 63.0 64.0 63.0 63.0 62.0 64.0 62.0 61.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:65.00 stddev:2.85 (4.4%) stddev-sans-first:3.00 18:39:05 INFO - PROCESS | 8228 | Values: 65.0 74.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.00 stddev:3.23 (4.1%) stddev-sans-first:3.40 18:39:05 INFO - PROCESS | 8228 | Values: 79.0 79.0 78.0 79.0 82.0 78.0 78.0 86.0 78.0 86.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:130.50 stddev:25.56 (19.6%) stddev-sans-first:27.10 18:39:05 INFO - PROCESS | 8228 | Values: 138.0 130.0 128.0 128.0 129.0 128.0 137.0 131.0 211.0 130.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.40 (1.5%) stddev-sans-first:2.44 18:39:05 INFO - PROCESS | 8228 | Values: 167.0 167.0 164.0 163.0 164.0 170.0 163.0 166.0 163.0 163.0 18:39:05 INFO - PROCESS | 8228 | 18:39:05 INFO - PROCESS | 8228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:2.05 (3.1%) stddev-sans-first:1.13 18:39:05 INFO - PROCESS | 8228 | Values: 72.0 69.0 66.0 66.0 65.0 66.0 66.0 66.0 67.0 67.0 18:39:05 INFO - PROCESS | 8228 | -------- Summary: end -------- 18:39:05 INFO - PROCESS | 8228 | 18:39:06 INFO - TEST-INFO | 8228: exit 0 18:39:06 INFO - TEST-OK | kraken | took 63477ms 18:39:06 INFO - SUITE-END | took 1183s 18:39:06 INFO - Completed test suite (00:19:43) 18:39:06 INFO - javascript benchmark 18:39:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.0981361430304, 2630.1977896741487, 2656.1500319897636, 2669.666291713536, 2675.8929642814287, 4654.441467023962, 4715.386999690039, 4717.929231061528, 4748.738819364938, 4786.353842231302, 4723.102610504002, 4769.785359658815, 4778.378810754597, 4786.952130478694, 4803.159447096753, 4155.958440415602, 4304.677149213806, 4366.104948485553, 4394.0, 4550.203714349992, 4459.777011149446, 4487.237169681162, 4507.909841803178, 4518.638508919295, 4544.341070544769, 4261.4460120184485, 4289.2922667759785, 4310.396544483775, 4346.891327716832, 4350.195213885441, 4319.114581510814, 4320.287152619814, 4342.435483387139, 4389.122175564899, 4427.048184640285, 4359.237133501656, 4360.258756011485, 4380.0582874682095, 4403.669724770623, 4404.66964977628, 4618.953810461886, 4650.534946505356, 4709.081729062834, 4782.497837727024, 4813.302071199656, 5073.137566613685, 5159.380874295109, 5172.715500647463, 5187.792488300463, 5190.2214667800135, 5187.403448603422, 5203.869903252411, 5206.635535512478, 5216.0, 5216.8695782605355, 4686.0, 4691.249400095969, 4715.882102947385, 4796.832110876103, 4845.830395936196, 5192.9740351298005, 5195.610329225323, 5199.2201169824075, 5248.239005344204, 5249.711265880337, 4989.426215985136, 5027.296178535008, 5037.722925239073, 5039.899202016012, 5047.091523525801, 4981.825636102792, 5059.443461219263, 5065.822696205689, 5102.336696229467, 5103.744812759347, 5017.54842064216, 5037.0681423936685, 5042.142835717937, 5066.569341606005, 5124.948750512447, 5057.645964782503, 5062.240663900371, 5065.442801291855, 5067.037262920034, 5071.518205770446, 4154.626083652486, 4185.162967406531, 4185.727927684691, 4231.0, 4237.427947227085, 3733.272011957642, 3737.6822970047306, 3755.962440375616, 3775.0562359410146, 3777.433384992273, 4372.759498227628, 4386.473623165177, 4400.537943515948, 4437.689361744647, 4443.0, 5159.58723302135, 5160.251763494347, 5163.096458119814, 5164.04465173944, 5212.452692467312, 4292.463442069741, 4371.278739008092, 4433.113377324548, 4442.20040392726, 4487.910241795146, 4514.029483661028, 4524.8416305429155, 4539.001419687664, 4572.565606267399, 4576.084783043405, 4793.424789025339, 4849.854504364875, 4851.490593487703, 4853.95146048542, 4899.461059283547, 5003.449620541664, 5036.722980236123, 5102.770375333193, 5126.307948426915, 5136.1268584340005, 4859.562639362474, 4864.221724524059, 4884.65807393479, 4886.120498310338, 4934.062528119646, 5086.135356989246, 5090.134677104975, 5094.770735316845, 5098.923516147335, 5149.0474262261605, 4970.3290055842, 5077.720725360141, 5121.1550094234035, 5153.098207813692, 5177.378714554127, 4959.380077490314, 4962.280469331855, 4973.104841128632, 4973.477784832685, 5012.924806127984, 4945.67853089548, 4980.477049909852, 4983.07813054586, 4986.975065124796, 5021.196608542616, 4712.670113092187, 4779.689320194177, 4812.230043193213, 4823.9517604824905, 4929.531694489161, 4918.975405122951, 4922.089413458521, 4941.589889849515, 4945.505449455026, 4975.5522003019905, 4832.081904438145, 4843.660943733905, 4847.224444088929, 4850.393700787402, 4891.657583969088], "value": 4675.656904034174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.1717585265145, 584.3134317177315, 584.6901142394532, 586.7037146241145, 590.8759160576279, 27172.0, 43968.34047489286, 45899.31151032733, 45905.540944590546, 45936.3109553357, 41249.38125928114, 41506.16987660245, 41678.16643667125, 41729.0, 41771.37342939851, 7511.774646760578, 7771.650275737577, 7917.524948503079, 7925.247101525375, 7927.246911543394, 7484.288992545699, 7745.845083098335, 7750.651220695082, 9929.702108936743, 10207.081362677358, 10249.948750256239, 10282.537285822156, 10300.484975751182, 10300.948495257551, 10316.845247321258, 10072.294939354248, 10096.0, 10159.949200254025, 10175.389476631426, 10177.033181847713, 7475.9252407476315, 9877.654282100164, 10215.23385746072, 10221.591136354537, 10540.051395374454, 39485.60514394848, 39899.40150897739, 39910.80044599788, 40047.19905601872, 40166.0, 2880.5967164596973, 3081.3683194944983, 3171.39743448744, 3298.686624770643, 3501.3172431375892, 29552.0, 29640.8517957411, 29738.10785676433, 29996.700032999608, 30133.246668833235, 3221.903342899717, 3258.5275135105276, 3287.161773747703, 3350.0954742219465, 3402.183475965775, 258076.0, 259236.0, 259388.0, 260025.69987150133, 261316.0, 31427.214319641735, 32483.18792030218, 54962.72518637381, 55433.44566554364, 55487.445125549035, 33554.0, 33878.830605846815, 33888.66111338855, 33909.830450847585, 33936.0, 13464.865351346558, 13672.179669219879, 13672.453101876012, 13674.0, 13690.178589284675, 9573.377730447499, 11512.827307590393, 11577.305361678325, 11583.189176757545, 11601.07191424684, 7684.884726729104, 7875.133735289113, 7908.130105688369, 7985.241402066795, 8050.798730031796, 3069.6930306969125, 3085.5371694245596, 3090.8918187863765, 3133.248020475115, 3143.6699146589735, 856.7087190355309, 894.141624040928, 910.0899100899101, 919.103873723128, 922.6678395777515, 28751.42497150087, 29136.562951555745, 29208.415831683247, 29454.705452945625, 29558.852205738833, 989.5003023473244, 991.5785791038779, 1005.0401866217744, 1005.8692369991854, 1030.3663247103127, 14999.925000374928, 15369.615759606098, 15491.380344786083, 15806.762898556532, 15828.208589570475, 372554.0, 387179.0, 387609.0, 387703.0, 389460.0, 50671.49328506668, 50973.490265097615, 51186.232206516936, 51219.23171152436, 51300.23049654258, 1088.1349327284986, 1165.1261553834624, 1175.1832476428972, 1206.288289908958, 1213.04775751035, 25938.610920835825, 29885.402291954473, 29974.550381744728, 30543.694563054087, 30590.235244119074, 43297.0, 43334.78332608317, 43708.78145609252, 43832.78083609562, 43902.560974389846, 289107.0, 289577.0, 290262.0, 290802.0, 291804.0, 22441.32676019722, 24881.62677559802, 25368.0, 25535.616965745157, 25699.614505782803, 42902.35646465243, 43168.56831431771, 43500.564994349654, 44151.77924110359, 44520.0, 36601.26797464089, 37345.43981840329, 37665.0, 37896.242075158894, 38057.80971095127, 36098.4585231227, 36458.8177059113, 36499.81750091232, 36530.452043219906, 37488.25023499569, 35652.28695426129, 36464.08839778921, 36661.81669091638, 37096.814515927246, 37317.81341093277, 32329.24098216364, 33098.33803323872, 34863.0, 34884.65115348814, 37516.741901880705, 25752.871235644452, 26059.869700651376, 26400.603990940537, 26577.734222657527, 26788.0], "value": 17065.368747958633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.301925399503, 376.4240711711082, 378.31902575364336, 384.85183204466273, 397.39794211769174, 16414.261358238877, 17115.82884171158, 17420.128993550305, 17903.0, 17907.82092179078, 10690.572377104907, 10926.562937482511, 10966.835497467544, 11000.779984400308, 11008.944955275212, 4291.733938488153, 4608.308753686941, 5382.784688612451, 5403.756830942617, 5414.214938833867, 5175.741212939338, 5201.713905735183, 5214.947850521484, 5228.712420816853, 5245.082110630643, 5090.974545127269, 5193.376794784613, 5294.311739473863, 5300.496452836975, 5300.575953923677, 5285.68285902847, 5287.101192797195, 5293.550048245904, 5302.469753024686, 5302.6023048271345, 4576.473705523841, 4801.039792041605, 4803.471618122004, 4804.495527969548, 4817.51824817519, 21358.252461163785, 21498.462538436663, 21850.672239916414, 22318.2188623399, 22393.0, 1710.9230084646222, 1834.1562881074722, 1856.5358660334916, 1916.7316575679415, 1975.5555000125, 9616.374935629161, 9926.652567160114, 10054.195664346908, 11016.779664406748, 14357.0, 1606.1246620591805, 1685.6460143369907, 1697.651981343834, 1699.1164594410961, 1716.9914150429292, 52336.0, 65223.99999999953, 67104.32895671029, 67676.32323676799, 76259.23740762577, 10180.847287290548, 10396.948015260026, 10531.894681053245, 10581.41802200871, 10592.788144237073, 12635.810462843065, 13019.609411717664, 13801.51694690681, 13857.722845543032, 14278.714425711427, 7024.508284420143, 7102.0, 7156.892646610305, 7242.0, 7285.817854553573, 6527.118838956775, 6553.377429144319, 6694.330566943364, 6712.026756120335, 6746.730130794811, 4395.7362558246605, 4507.076049409863, 4508.639308855284, 4513.75174365413, 4591.150637132141, 1824.6077093424713, 1875.315509838899, 1910.1881700277604, 1919.0884329943165, 1931.2757715856553, 748.5695724958061, 839.7942504086416, 840.7225615546855, 860.3762272352494, 901.2339511415375, 17072.48782536526, 17227.913860430617, 17336.479905602853, 17533.649327013387, 17667.20497577612, 823.880537322097, 825.6986200036944, 827.230675471805, 859.5788063848669, 915.496476937695, 9710.17463515609, 9903.504824758877, 10013.399196048114, 10022.949885250528, 10199.643012494527, 354694.0, 374853.0, 375737.0, 376150.0, 378387.0, 77394.0, 78234.6088269555, 78878.60560697275, 79021.20978790254, 79460.0, 894.9552522373855, 904.5025236120108, 911.7629416351664, 922.1884741427501, 928.7863791327898, 15325.0, 15898.284577193823, 16104.597385065466, 16169.116986555622, 16326.428574999818, 38071.2385752289, 38470.23059538849, 38621.80689096537, 39166.80416597899, 39651.405228922165, 51338.74330628323, 52217.7389113052, 52230.47769522408, 52472.21291680552, 52498.73750631375, 6923.169219693669, 7076.964615176891, 7938.920610794049, 8033.5983200838555, 8183.631736571988, 11768.94115529417, 12219.144659873724, 12570.811437828257, 12633.0, 12739.936300318439, 10610.310329828537, 10764.946175269073, 10830.67507974762, 10949.562017519529, 10962.725931851448, 10539.525721342712, 10908.945455272673, 11057.778844423228, 11082.0, 11159.776804463703, 10053.849192262269, 10602.681919542427, 10750.677479675622, 10878.23852330361, 10979.066779323846, 6971.51199416036, 7079.43364530826, 7107.18267399235, 7133.3936615388275, 7429.777106686808, 10318.742031449274, 10488.790224195625, 10544.947275263574, 10615.575376985144, 10682.786344272916], "value": 8166.247264060214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.7518496300743, 1396.7834985577233, 1443.3216388297499, 1524.3216768538005, 1753.5265478320853, 6818.181818181819, 7630.504017238875, 7865.134835168141, 7876.881846772289, 7885.763427097189, 7504.137024242214, 7739.419543534229, 7743.380529557636, 7934.285914267714, 7934.880976785353, 1932.9613407731838, 2168.219441001246, 2212.889355532221, 2269.807066399358, 2272.738635056965, 2272.5909336319455, 2281.2129815213725, 2283.7031185945802, 2285.542891421714, 2285.611446054175, 2260.3106052653934, 2260.954780904381, 2296.0930432479163, 2298.367948814073, 2302.309307207831, 1863.7018077107734, 2081.3859911326044, 2162.426956856434, 2165.956680866374, 2186.9015894284717, 2217.401301648546, 2233.475133343663, 2237.7985981261763, 2238.373255488466, 2241.2155745489113, 7978.361731061559, 8028.839423211562, 8029.156938521488, 8031.1165771765645, 8033.718819841336, 4585.151746926829, 4693.507181745936, 4712.340272361872, 4722.693024953402, 4723.36234608327, 2744.0395861448533, 2824.350399408127, 2894.3921776426973, 2899.246195989058, 2908.8400137992403, 889.7642124836923, 891.8038031633031, 899.2131884600974, 1603.8636715879163, 1644.4984279794658, 10916.126709863192, 11140.498677559448, 11150.386728729836, 11158.0, 11165.83251251232, 4335.934960975588, 4342.457192850894, 4516.954830451654, 4519.412476378116, 4528.456585209796, 9469.857952130724, 9498.667546635834, 9510.0, 9530.332876698565, 9536.475493847905, 4895.241237608177, 4897.461279259279, 4900.681455705368, 4902.828401005948, 4904.215325547895, 3767.585565587783, 4251.511076226212, 4380.299152135643, 4391.07787364657, 4470.6870519064005, 3740.925181496355, 3777.527809023872, 3828.062124779447, 3866.4200369944733, 3883.3204189266767, 1092.9125669946386, 1142.5772464188137, 1179.9587014454453, 1182.8403165572538, 1205.6376294786835, 668.7024274198033, 733.3070248615114, 791.6912404162381, 801.8115742800437, 802.1577343789115, 5066.594672426197, 5293.338332708411, 5332.253484512172, 5457.099578569571, 5577.330720313588, 811.8944537210243, 834.0491839303199, 851.9105493923173, 879.1779685993616, 910.9089091090838, 3180.475221588412, 3365.242820365447, 3387.6442973487924, 3392.4741665041956, 3410.5395771571016, 9770.706878793648, 9916.504174791231, 9945.303828732063, 10020.949895250624, 10037.849432258521, 9907.6624655672, 9929.354591951644, 9932.404055756677, 9938.602455901682, 9939.50302484873, 7359.337659610661, 7426.071741032371, 7535.8116047098165, 7554.169041405441, 7589.620518974029, 4770.0, 4845.394325709286, 4851.369321988119, 4871.098846713369, 4955.950440495549, 9181.806365172484, 9234.815303693755, 9319.813603728024, 9335.57989890443, 9355.812883742423, 9089.818203636023, 9543.4751088688, 9547.904520954702, 9557.808843823224, 9578.137967582672, 6353.301136875032, 6483.610983341015, 6488.2538508072175, 6489.7404103835315, 6496.837579060561, 7371.557706537625, 7429.294217049372, 7429.8142546436775, 7445.553266804009, 7445.9627701861145, 5500.9174862377895, 6461.19235095613, 6589.505787065893, 6858.417034552119, 7028.683709232994, 6822.624755638488, 6912.827179320558, 6934.583924964519, 7006.894896576454, 7110.32451917067, 5965.940340596539, 6064.969675151596, 6109.11417844419, 6110.2973158085615, 6111.908321375272, 4634.976825115853, 4647.697899636512, 4692.741899195577, 4705.7411842349, 4741.810327586858, 4340.913181736284, 4355.210662894622, 4431.202383570988, 4547.113312903952, 4547.522510136388], "value": 4192.719147847978, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.8555207948106, 299.89353779408304, 304.74553747620735, 306.32761089408757, 306.3551224672065, 4754.3819303490545, 4805.711657300556, 4844.442889067754, 4850.587700045491, 4853.999999999995, 4526.343680166374, 4612.86161415158, 4643.837465688702, 4676.532346765322, 4775.90448191036, 3675.0, 3699.741018128732, 3705.944410833826, 3760.548734151892, 3820.522434695663, 3759.906002349936, 3788.2802267569073, 3800.4869342638804, 3822.636849499293, 3829.8276577554075, 3694.242680250542, 3775.377062784651, 3785.3754130568423, 3804.4293355996683, 3809.409541521055, 3788.3559794834805, 3789.242151569697, 3800.7339486235974, 3805.7906815125157, 3816.7709937403565, 3354.245294808673, 3355.1612096975755, 3360.54632624595, 3362.5796775403073, 3379.7803142795638, 4675.929861052087, 4683.414573178353, 4704.764761761899, 4712.31671407644, 4719.480857105716, 4155.065110350177, 4323.135372925428, 4324.113556720865, 4367.563243675607, 4396.604305612478, 5038.168702164138, 5044.571211447032, 5047.318611987408, 5068.949310506885, 5073.213651883927, 3665.7617254878346, 3699.9815000924823, 3702.129999450127, 3719.6466335698065, 3727.347714150013, 5159.845204643867, 5286.497782710637, 5294.0, 5296.894062118775, 5315.123004704258, 3756.1173124315765, 3762.492063571383, 3766.6798322142927, 3769.208466222069, 3784.0, 3818.6372294631965, 3819.834950340173, 3833.3674943633987, 3837.597052309523, 3838.961610383916, 4326.156399502067, 4356.455443069616, 4358.847440339637, 4363.6072753452345, 4372.825086996548, 4877.609791216694, 4999.900001999939, 5012.7718708916545, 5021.924671129936, 5045.571126454219, 1307.4966138036925, 1319.3798914510164, 1321.5110409148485, 1328.634625477982, 1331.5872079655337, 873.785922449004, 904.2856143646445, 930.1070971867083, 939.3940908114228, 940.83535381308, 4391.758453285036, 4399.12017596482, 4421.11577684458, 4426.734395936254, 4431.423914891044, 5097.617678674114, 5103.081445339801, 5111.591072714174, 5124.333836601292, 5134.614903882149, 4288.649075541194, 4433.312836510346, 4435.290353543418, 4442.355858400514, 4451.821927122879, 2707.3502359433596, 2727.9863600682265, 2731.4810186064983, 2732.6584176977876, 2737.3293543082073, 4853.611711063107, 4864.148773964542, 4865.854024379274, 4867.367242258484, 4871.853844384604, 5040.521150490697, 5245.370555533361, 5256.211568264791, 5308.840734777886, 5319.654222475527, 4873.80504779812, 4903.289023091632, 4920.384951881087, 4929.654924155275, 4929.876753081202, 5194.480551944926, 5199.63602547818, 5200.167973124282, 5240.580753539632, 5251.422343542284, 4892.3884514435695, 5156.865489592284, 5167.483251674803, 5174.7153906535505, 5187.299714538489, 4955.909699866023, 4974.776135073858, 4979.601631869369, 4990.301357809837, 5005.099082165245, 3722.9069273268383, 3746.4380342948775, 3748.1566647505183, 3757.981210093932, 3762.5673047599876, 5135.460776618551, 5247.790088396574, 5317.893642127213, 5320.388155362183, 5321.627486075938, 5027.572656324253, 5039.571636410946, 5052.267421223975, 5073.92389114171, 5088.59291256706, 5030.496950305087, 5030.974845125751, 5048.974755126201, 5062.645614806928, 5082.644214904921, 4706.717596944194, 4711.458182309078, 4943.258511223202, 4967.975160124176, 5043.9747801260755, 4949.752512374295, 4954.126606568109, 4960.900781984268, 4979.800807967641, 4986.650934434555, 4835.2505361669, 4940.481249468898, 4977.576905963034, 4993.375828021497, 4994.800207991785], "value": 3827.374111261961, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.4883439751392, 674.4941294029475, 684.9246582875884, 704.69345834562, 751.9735560959289, 11553.133514986368, 12026.579069732561, 12045.0, 12047.09646776493, 12064.879351206486, 11368.943155284232, 11544.942275288611, 11548.422578871045, 11550.884491155086, 11562.59530916418, 627.6485168305741, 760.8440269744717, 765.3723946363983, 777.4790890103644, 778.3928535742102, 766.9079710434728, 767.1024900866, 767.2021098058041, 767.6929228308666, 781.8514482248384, 813.5078277642031, 814.1370147643516, 814.6252723747084, 814.7881550796806, 814.816666250095, 649.7401039584204, 793.7896457438783, 805.2631841864745, 806.9838603227932, 810.3638643664724, 591.8283697727654, 592.1266132454638, 592.2034863109154, 592.2448877680948, 593.3413910559276, 11731.88268117325, 11771.352575608338, 11780.0, 11780.352080635561, 11784.175107742461, 11556.768864622745, 11564.53741850325, 11839.585614503538, 12055.698607534794, 12066.336351500664, 11151.944240278828, 11230.438478076063, 11346.886531134747, 11548.53805847765, 11721.94139029308, 3736.6076561960876, 3806.0484878780303, 3828.8659896903755, 3890.2414029264305, 3926.823292951824, 60212.096818547754, 60880.391196087476, 60895.39104608942, 61717.69141154311, 62075.689621552054, 9327.533623318806, 9911.603535858629, 9963.053509916546, 9995.0, 10090.192784577217, 15805.36778528869, 15988.200589970687, 16115.516534503984, 16143.0, 16164.353425862833, 6212.0, 6293.1504246927, 6312.43188113072, 6316.905246421307, 6391.776287829904, 3714.33142034431, 3788.924221515554, 3796.2217745362136, 3808.504894363715, 3860.2279544091293, 2731.6039174319612, 2825.6044153818484, 2837.163036904118, 2839.205022593677, 2839.9148025559266, 484.1623990496391, 500.039923347167, 512.0297037114647, 512.1370490723143, 513.3480479790719, 448.82047181127155, 470.097412967104, 492.3845193508115, 547.805529037194, 605.2343785111836, 7482.551046937092, 7998.685802183411, 8072.556009419421, 8112.985876765404, 8340.62467188978, 475.5387274343881, 546.2189069630388, 552.7899398228648, 564.9858753531113, 593.1873333533088, 3872.28362752886, 3895.844166233319, 4024.577419370924, 4116.897077573085, 4201.810918508674, 79397.0, 91875.54062229647, 92390.14683751822, 94474.0, 94783.0, 50438.74780626073, 66239.0, 68202.0, 83190.58404708059, 86168.56915715382, 44908.3263751044, 60731.0, 61785.691071545254, 63711.6814415925, 72858.99999999894, 8128.63421146038, 8361.540115293717, 8409.2431681149, 8516.659333626585, 8586.71240958417, 31868.84065579657, 44657.33014004857, 44901.0, 45002.77498612486, 45512.54487455083, 62890.339869411975, 65179.674101629185, 65679.67160164169, 65916.67041664761, 65956.34043659693, 10565.841512377474, 10946.616868409568, 11001.284916480403, 11191.832122518006, 11292.0, 12995.28525931083, 13034.54379096765, 13257.602271931857, 13492.730145397234, 14021.929890350482, 11902.226355287225, 12467.75064498723, 12559.37203139821, 12573.685657858627, 12679.873201267868, 11825.763484730429, 11855.52577896909, 12355.567555135887, 12363.93818030904, 12364.0, 11544.249623774427, 11683.824742628698, 12024.939875300568, 12445.502179912703, 12450.319206906952, 10097.596096156072, 10225.43760093202, 10311.07200351972, 10467.738306542398, 10584.259101862795, 9832.164266037467, 10179.592816287266, 10264.127549158107, 10300.896991029993, 10315.793684126125], "value": 6381.073019051232, "unit": "score"}], "name": "dromaeo_css", "value": 6368.734101179086, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 111.0, 112.0, 111.0, 112.0, 110.0, 113.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 123.0, 176.0, 123.0, 123.0, 148.0, 122.0, 167.0, 126.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 163.0, 164.0, 162.0, 162.0, 163.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 132.0, 76.0, 77.0, 75.0, 74.0, 113.0, 76.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 119.0, 86.0, 86.0, 86.0, 114.0, 85.0, 85.0, 126.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 64.0, 63.0, 63.0, 62.0, 64.0, 62.0, 61.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 82.0, 78.0, 78.0, 86.0, 78.0, 86.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 128.0, 128.0, 129.0, 128.0, 137.0, 131.0, 211.0, 130.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 164.0, 163.0, 164.0, 170.0, 163.0, 166.0, 163.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1531.2, "alertThreshold": 2.0}]} 18:39:06 INFO - Return code: 0 18:39:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:39:06 INFO - # TBPL SUCCESS # 18:39:06 INFO - Running post-action listener: _resource_record_post_action 18:39:06 INFO - ##### 18:39:06 INFO - ##### Finished run-tests step (success) 18:39:06 INFO - ##### 18:39:06 INFO - Running post-run listener: _resource_record_post_run 18:39:06 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 547430400; Read time: 0; Write time: 562364 18:39:06 INFO - TinderboxPrint: CPU usage
12.9% 18:39:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:39:06 INFO - TinderboxPrint: I/O write bytes / time
547,430,400 / 562,364 18:39:06 INFO - TinderboxPrint: CPU idle
8,336.5 (87.0%) 18:39:06 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 18:39:06 INFO - TinderboxPrint: Swap in / out
0 / 0 18:39:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259436544; Read time: 0; Write time: 306188 18:39:06 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287993856; Read time: 0; Write time: 256176 18:39:07 INFO - Running post-run listener: _upload_blobber_files 18:39:07 INFO - Blob upload gear active. 18:39:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:39:07 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:39:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:39:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:08 INFO - (blobuploader) - INFO - Done attempting. 18:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:39:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:11 INFO - (blobuploader) - INFO - Done attempting. 18:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:12 INFO - (blobuploader) - INFO - Done attempting. 18:39:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:12 INFO - Return code: 0 18:39:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f54f26d3a8ce2b97d178c25885d85db5e9e4c17185c65c79bb769ee0e213f94bc81aeb3dd506cb281e9c16a0a3dd3e54560dcd6aa2d04e24103b2c15da0001b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a23e075bc45e7fd738cca488b4b52dbdc5dda248e9606ed9e1e017a705f5ec3e500a57bb551112ebbc71a226632758aeb9aa255c678bc634d645618f1126d92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f37faccecf90d1d6f0eb5bc7e7ccc63098b62a940662db7744552fa5f637593e0920933bafb9349626142ee8969db656e26f3a559cef6e82245fe409dc2dd6d7"} 18:39:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:12 INFO - Contents: 18:39:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f54f26d3a8ce2b97d178c25885d85db5e9e4c17185c65c79bb769ee0e213f94bc81aeb3dd506cb281e9c16a0a3dd3e54560dcd6aa2d04e24103b2c15da0001b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a23e075bc45e7fd738cca488b4b52dbdc5dda248e9606ed9e1e017a705f5ec3e500a57bb551112ebbc71a226632758aeb9aa255c678bc634d645618f1126d92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f37faccecf90d1d6f0eb5bc7e7ccc63098b62a940662db7744552fa5f637593e0920933bafb9349626142ee8969db656e26f3a559cef6e82245fe409dc2dd6d7"} 18:39:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:12 INFO - Copying logs to upload dir... 18:39:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:39:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.033109 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-06 18:39:11.861821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 18:39:11.865491) ========= 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=920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492 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/f54f26d3a8ce2b97d178c25885d85db5e9e4c17185c65c79bb769ee0e213f94bc81aeb3dd506cb281e9c16a0a3dd3e54560dcd6aa2d04e24103b2c15da0001b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a23e075bc45e7fd738cca488b4b52dbdc5dda248e9606ed9e1e017a705f5ec3e500a57bb551112ebbc71a226632758aeb9aa255c678bc634d645618f1126d92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f37faccecf90d1d6f0eb5bc7e7ccc63098b62a940662db7744552fa5f637593e0920933bafb9349626142ee8969db656e26f3a559cef6e82245fe409dc2dd6d7"} build_url:https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/XyyvoJPFT260Y12Fjzle3g/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/f54f26d3a8ce2b97d178c25885d85db5e9e4c17185c65c79bb769ee0e213f94bc81aeb3dd506cb281e9c16a0a3dd3e54560dcd6aa2d04e24103b2c15da0001b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a23e075bc45e7fd738cca488b4b52dbdc5dda248e9606ed9e1e017a705f5ec3e500a57bb551112ebbc71a226632758aeb9aa255c678bc634d645618f1126d92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f37faccecf90d1d6f0eb5bc7e7ccc63098b62a940662db7744552fa5f637593e0920933bafb9349626142ee8969db656e26f3a559cef6e82245fe409dc2dd6d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 18:39:11.891106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:39:11.891439) ========= 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=920470bf432669ad7e3a5387000001ca-1467852685.320587-1234567492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:39:11.975101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 18:39:11.975435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 18:39:11.975774) ========= ========= Total master_lag: 0.17 =========