builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1475632391.18 results: success (0) buildid: 20161004173300 builduid: 0aca29779576402ab0b092faf4fdfc0f revision: 9dc03b80c67223e32853b309e6c95fdd182061ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.183750) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.184167) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.184452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.229615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.229961) ========= 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=db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 18:53:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.0M=0.001s 2016-10-04 18:53:11 (16.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121543 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.549980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.550294) ========= 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=db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015876 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.597767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:11.598122) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9dc03b80c67223e32853b309e6c95fdd182061ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9dc03b80c67223e32853b309e6c95fdd182061ba --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=db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 18:53:11,867 truncating revision to first 12 chars 2016-10-04 18:53:11,868 Setting DEBUG logging. 2016-10-04 18:53:11,868 attempt 1/10 2016-10-04 18:53:11,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9dc03b80c672?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 18:53:12,407 unpacking tar archive at: mozilla-central-9dc03b80c672/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:12.533028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:12.533354) ========= script_repo_revision: 9dc03b80c67223e32853b309e6c95fdd182061ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:12.533781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:12.534097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 18:53:12.544801) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 18:53:12.545158) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:53:12 INFO - MultiFileLogger online at 20161004 18:53:12 in /builds/slave/test 18:53:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:53:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:53:12 INFO - {'append_to_log': False, 18:53:12 INFO - 'base_work_dir': '/builds/slave/test', 18:53:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:53:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:53:12 INFO - 'branch': 'Firefox-Non-PGO', 18:53:12 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:12 INFO - 'config_files': ('talos/linux_config.py',), 18:53:12 INFO - 'default_actions': ('clobber', 18:53:12 INFO - 'read-buildbot-config', 18:53:12 INFO - 'download-and-extract', 18:53:12 INFO - 'populate-webroot', 18:53:12 INFO - 'create-virtualenv', 18:53:12 INFO - 'install', 18:53:12 INFO - 'run-tests'), 18:53:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:12 INFO - 'download_minidump_stackwalk': True, 18:53:12 INFO - 'download_symbols': 'ondemand', 18:53:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:12 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:12 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:12 INFO - 'installer_path': 'installer.exe', 18:53:12 INFO - 'log_level': 'info', 18:53:12 INFO - 'log_name': 'talos', 18:53:12 INFO - 'log_to_console': True, 18:53:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:53:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:53:12 INFO - 'opt_config_files': (), 18:53:12 INFO - 'pip_index': False, 18:53:12 INFO - 'sps_profile': False, 18:53:12 INFO - 'sps_profile_interval': 0, 18:53:12 INFO - 'suite': 'dromaeojs', 18:53:12 INFO - 'system_bits': '32', 18:53:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:12 INFO - 'title': 'talos-linux64-ix-049', 18:53:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:12 INFO - 'use_talos_json': True, 18:53:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:53:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:12 INFO - 'work_dir': 'build'} 18:53:12 INFO - [mozharness: 2016-10-05 01:53:12.904787Z] Running clobber step. 18:53:12 INFO - Running pre-action listener: _resource_record_pre_action 18:53:12 INFO - Running main action method: clobber 18:53:12 INFO - rmtree: /builds/slave/test/build 18:53:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:53:13 INFO - Running post-action listener: _resource_record_post_action 18:53:13 INFO - [mozharness: 2016-10-05 01:53:13.357883Z] Finished clobber step (success) 18:53:13 INFO - [mozharness: 2016-10-05 01:53:13.357983Z] Running read-buildbot-config step. 18:53:13 INFO - Running pre-action listener: _resource_record_pre_action 18:53:13 INFO - Running main action method: read_buildbot_config 18:53:13 INFO - Using buildbot properties: 18:53:13 INFO - { 18:53:13 INFO - "project": "", 18:53:13 INFO - "product": "firefox", 18:53:13 INFO - "script_repo_revision": "production", 18:53:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:53:13 INFO - "repository": "", 18:53:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:53:13 INFO - "buildid": "20161004173300", 18:53:13 INFO - "pgo_build": "False", 18:53:13 INFO - "basedir": "/builds/slave/test", 18:53:13 INFO - "buildnumber": 765, 18:53:13 INFO - "slavename": "talos-linux64-ix-049", 18:53:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:53:13 INFO - "platform": "ubuntu64_hw", 18:53:13 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:53:13 INFO - "branch": "mozilla-central", 18:53:13 INFO - "repo_path": "mozilla-central", 18:53:13 INFO - "revision": "9dc03b80c67223e32853b309e6c95fdd182061ba", 18:53:13 INFO - "stage_platform": "linux64", 18:53:13 INFO - "builduid": "0aca29779576402ab0b092faf4fdfc0f", 18:53:13 INFO - "slavebuilddir": "test" 18:53:13 INFO - } 18:53:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:53:13 INFO - Running post-action listener: _resource_record_post_action 18:53:13 INFO - [mozharness: 2016-10-05 01:53:13.360395Z] Finished read-buildbot-config step (success) 18:53:13 INFO - [mozharness: 2016-10-05 01:53:13.360483Z] Running download-and-extract step. 18:53:13 INFO - Running pre-action listener: _resource_record_pre_action 18:53:13 INFO - Running main action method: download_and_extract 18:53:13 INFO - mkdir: /builds/slave/test/build/tests 18:53:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:13 INFO - trying https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:53:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:53:13 INFO - Downloaded 1361 bytes. 18:53:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:53:13 INFO - Using the following test package requirements: 18:53:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:53:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:53:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'jsshell-linux-x86_64.zip'], 18:53:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:53:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:53:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:53:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:53:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:53:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:53:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:53:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:53:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:53:14 INFO - Http code: 200 18:53:14 INFO - via: 1.1 aa96a51fedae85199c643eb5c8eca4e4.cloudfront.net (CloudFront) 18:53:14 INFO - x-amz-cf-id: 8fbYJuaRjNAXWML65__KT8_2WNZMylFbYJy5bZhjqKJ23ZawWWHd4g== 18:53:14 INFO - x-amz-version-id: gY2ruLb_9fTYTE2Xu50WORhXZvclkBxF 18:53:14 INFO - Expected file size: 20420899 18:53:14 INFO - Obtained file size: 20420899 18:53:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:53:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:53:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:53:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:53:19 INFO - Http code: 200 18:53:19 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 18:53:19 INFO - x-amz-cf-id: V1RBLzMgUtcW6sLm06ndsLdBVnS2PLm28uR7jee86QzHjcxWjoPo9Q== 18:53:19 INFO - x-amz-version-id: gY2ruLb_9fTYTE2Xu50WORhXZvclkBxF 18:53:19 INFO - Expected file size: 20420899 18:53:19 INFO - Obtained file size: 20420899 18:53:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:53:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:53:24 INFO - Http code: 200 18:53:24 INFO - via: 1.1 ff09df097f823b2834408d17e9779d62.cloudfront.net (CloudFront) 18:53:24 INFO - x-amz-cf-id: 0P1DeLc-R7dTDrM5CWVgZlHhtuJzvU_pYphZuiHe2G51yDKjHYKukQ== 18:53:24 INFO - x-amz-version-id: 3CGm31xBB27AhiuwWEm9h7KFdc7.b4FN 18:53:24 INFO - Expected file size: 14409006 18:53:24 INFO - Obtained file size: 14409006 18:53:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:24 INFO - trying https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:53:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:53:26 INFO - Downloaded 55786697 bytes. 18:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:53:26 INFO - mkdir: /builds/slave/test/properties 18:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 18:53:26 INFO - Contents: 18:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:53:26 INFO - Running post-action listener: _resource_record_post_action 18:53:26 INFO - Running post-action listener: set_extra_try_arguments 18:53:26 INFO - [mozharness: 2016-10-05 01:53:26.775467Z] Finished download-and-extract step (success) 18:53:26 INFO - [mozharness: 2016-10-05 01:53:26.775764Z] Running populate-webroot step. 18:53:26 INFO - Running pre-action listener: _resource_record_pre_action 18:53:26 INFO - Running main action method: populate_webroot 18:53:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:26 INFO - '--tppagecycles', 18:53:26 INFO - '7'], 18:53:26 INFO - 'tests': ['tsvgm']}}, 18:53:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:53:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:53:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:53:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['damp', 'tps']}, 18:53:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['damp', 'tps']}, 18:53:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['dromaeo_dom']}, 18:53:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:53:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['basic_compositor_video']}, 18:53:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:53:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tsvgx', 18:53:26 INFO - 'tsvgr_opacity', 18:53:26 INFO - 'tart', 18:53:26 INFO - 'tscrollx', 18:53:26 INFO - 'cart']}, 18:53:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:53:26 INFO - 'tsvgr_opacity', 18:53:26 INFO - 'tart', 18:53:26 INFO - 'tscrollx', 18:53:26 INFO - 'cart']}, 18:53:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tp5o']}, 18:53:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['tp5o']}, 18:53:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s', 18:53:26 INFO - '--xperf_path', 18:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:26 INFO - 'tests': ['tp5n']}, 18:53:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--xperf_path', 18:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:26 INFO - 'tests': ['tp5n']}}, 18:53:26 INFO - 'talos.zip': {'path': '', 18:53:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:26 INFO - Running post-action listener: _resource_record_post_action 18:53:26 INFO - [mozharness: 2016-10-05 01:53:26.796691Z] Finished populate-webroot step (success) 18:53:26 INFO - [mozharness: 2016-10-05 01:53:26.796784Z] Running create-virtualenv step. 18:53:26 INFO - Running pre-action listener: _resource_record_pre_action 18:53:26 INFO - Running main action method: create_virtualenv 18:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 18:53:26 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:53:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:53:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:26 INFO - Using real prefix '/usr' 18:53:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:53:27 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:29 INFO - Installing pip.................done. 18:53:29 INFO - Return code: 0 18:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:53:29 INFO - Reading from file tmpfile_stdout 18:53:29 INFO - Output received: 18:53:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:53:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:53:29 INFO - Using env: {'DISPLAY': ':0', 18:53:29 INFO - 'HOME': '/home/cltbld', 18:53:29 INFO - 'LANG': 'en_US.UTF-8', 18:53:29 INFO - 'LANGUAGE': 'en_US:en', 18:53:29 INFO - 'LOGNAME': 'cltbld', 18:53:29 INFO - 'MAIL': '/var/mail/cltbld', 18:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:29 INFO - 'MOZ_NO_REMOTE': '1', 18:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:29 INFO - 'NO_EM_RESTART': '1', 18:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:29 INFO - 'PWD': '/builds/slave/test', 18:53:29 INFO - 'SHELL': '/bin/bash', 18:53:29 INFO - 'SHLVL': '1', 18:53:29 INFO - 'TERM': 'linux', 18:53:29 INFO - 'TMOUT': '86400', 18:53:29 INFO - 'USER': 'cltbld', 18:53:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:29 INFO - '_': '/tools/buildbot/bin/python'} 18:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:29 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:53:29 INFO - Cleaning up... 18:53:29 INFO - Return code: 0 18:53:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:53:29 INFO - Using env: {'DISPLAY': ':0', 18:53:29 INFO - 'HOME': '/home/cltbld', 18:53:29 INFO - 'LANG': 'en_US.UTF-8', 18:53:29 INFO - 'LANGUAGE': 'en_US:en', 18:53:29 INFO - 'LOGNAME': 'cltbld', 18:53:29 INFO - 'MAIL': '/var/mail/cltbld', 18:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:29 INFO - 'MOZ_NO_REMOTE': '1', 18:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:29 INFO - 'NO_EM_RESTART': '1', 18:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:29 INFO - 'PWD': '/builds/slave/test', 18:53:29 INFO - 'SHELL': '/bin/bash', 18:53:29 INFO - 'SHLVL': '1', 18:53:29 INFO - 'TERM': 'linux', 18:53:29 INFO - 'TMOUT': '86400', 18:53:29 INFO - 'USER': 'cltbld', 18:53:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:29 INFO - '_': '/tools/buildbot/bin/python'} 18:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:30 INFO - Downloading/unpacking psutil>=3.1.1 18:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:32 INFO - Installing collected packages: psutil 18:53:32 INFO - Running setup.py install for psutil 18:53:32 INFO - building 'psutil._psutil_linux' extension 18:53:32 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:53:32 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:53:32 INFO - building 'psutil._psutil_posix' extension 18:53:32 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:53:32 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:53:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:32 INFO - Successfully installed psutil 18:53:32 INFO - Cleaning up... 18:53:32 INFO - Return code: 0 18:53:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:53:32 INFO - Using env: {'DISPLAY': ':0', 18:53:32 INFO - 'HOME': '/home/cltbld', 18:53:32 INFO - 'LANG': 'en_US.UTF-8', 18:53:32 INFO - 'LANGUAGE': 'en_US:en', 18:53:32 INFO - 'LOGNAME': 'cltbld', 18:53:32 INFO - 'MAIL': '/var/mail/cltbld', 18:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:32 INFO - 'MOZ_NO_REMOTE': '1', 18:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:32 INFO - 'NO_EM_RESTART': '1', 18:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:32 INFO - 'PWD': '/builds/slave/test', 18:53:32 INFO - 'SHELL': '/bin/bash', 18:53:32 INFO - 'SHLVL': '1', 18:53:32 INFO - 'TERM': 'linux', 18:53:32 INFO - 'TMOUT': '86400', 18:53:32 INFO - 'USER': 'cltbld', 18:53:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:32 INFO - '_': '/tools/buildbot/bin/python'} 18:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:53:34 INFO - Installing collected packages: mozsystemmonitor 18:53:34 INFO - Running setup.py install for mozsystemmonitor 18:53:34 INFO - Successfully installed mozsystemmonitor 18:53:34 INFO - Cleaning up... 18:53:34 INFO - Return code: 0 18:53:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:53:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:34 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 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:34 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:53:34 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:53:34 INFO - Using env: {'DISPLAY': ':0', 18:53:34 INFO - 'HOME': '/home/cltbld', 18:53:34 INFO - 'LANG': 'en_US.UTF-8', 18:53:34 INFO - 'LANGUAGE': 'en_US:en', 18:53:34 INFO - 'LOGNAME': 'cltbld', 18:53:34 INFO - 'MAIL': '/var/mail/cltbld', 18:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:34 INFO - 'MOZ_NO_REMOTE': '1', 18:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:34 INFO - 'NO_EM_RESTART': '1', 18:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:34 INFO - 'PWD': '/builds/slave/test', 18:53:34 INFO - 'SHELL': '/bin/bash', 18:53:34 INFO - 'SHLVL': '1', 18:53:34 INFO - 'TERM': 'linux', 18:53:34 INFO - 'TMOUT': '86400', 18:53:34 INFO - 'USER': 'cltbld', 18:53:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:34 INFO - '_': '/tools/buildbot/bin/python'} 18:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:35 INFO - Downloading/unpacking jsonschema==2.5.1 18:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:53:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:53:37 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:53:37 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:53:37 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:53:37 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:53:37 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:53:37 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:53:37 INFO - Downloading functools32-3.2.3-2.tar.gz 18:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:53:37 INFO - warning: no files found matching '*.txt' 18:53:37 INFO - no previously-included directories found matching 'build' 18:53:37 INFO - no previously-included directories found matching 'dist' 18:53:37 INFO - no previously-included directories found matching '.git*' 18:53:37 INFO - Installing collected packages: jsonschema, functools32 18:53:37 INFO - Running setup.py install for functools32 18:53:37 INFO - warning: no files found matching '*.txt' 18:53:37 INFO - no previously-included directories found matching 'build' 18:53:37 INFO - no previously-included directories found matching 'dist' 18:53:37 INFO - no previously-included directories found matching '.git*' 18:53:37 INFO - Successfully installed jsonschema functools32 18:53:37 INFO - Cleaning up... 18:53:37 INFO - Return code: 0 18:53:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:37 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:53:37 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 functools32==3.2.3-2 18:53:37 INFO - Using env: {'DISPLAY': ':0', 18:53:37 INFO - 'HOME': '/home/cltbld', 18:53:37 INFO - 'LANG': 'en_US.UTF-8', 18:53:37 INFO - 'LANGUAGE': 'en_US:en', 18:53:37 INFO - 'LOGNAME': 'cltbld', 18:53:37 INFO - 'MAIL': '/var/mail/cltbld', 18:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:37 INFO - 'MOZ_NO_REMOTE': '1', 18:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:37 INFO - 'NO_EM_RESTART': '1', 18:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:37 INFO - 'PWD': '/builds/slave/test', 18:53:37 INFO - 'SHELL': '/bin/bash', 18:53:37 INFO - 'SHLVL': '1', 18:53:37 INFO - 'TERM': 'linux', 18:53:37 INFO - 'TMOUT': '86400', 18:53:37 INFO - 'USER': 'cltbld', 18:53:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:37 INFO - '_': '/tools/buildbot/bin/python'} 18:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:53:37 INFO - Cleaning up... 18:53:37 INFO - Return code: 0 18:53:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 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 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:37 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:53:37 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:53:37 INFO - Using env: {'DISPLAY': ':0', 18:53:37 INFO - 'HOME': '/home/cltbld', 18:53:37 INFO - 'LANG': 'en_US.UTF-8', 18:53:37 INFO - 'LANGUAGE': 'en_US:en', 18:53:37 INFO - 'LOGNAME': 'cltbld', 18:53:37 INFO - 'MAIL': '/var/mail/cltbld', 18:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:37 INFO - 'MOZ_NO_REMOTE': '1', 18:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:37 INFO - 'NO_EM_RESTART': '1', 18:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:37 INFO - 'PWD': '/builds/slave/test', 18:53:37 INFO - 'SHELL': '/bin/bash', 18:53:37 INFO - 'SHLVL': '1', 18:53:37 INFO - 'TERM': 'linux', 18:53:37 INFO - 'TMOUT': '86400', 18:53:37 INFO - 'USER': 'cltbld', 18:53:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:37 INFO - '_': '/tools/buildbot/bin/python'} 18:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:37 INFO - Downloading/unpacking blobuploader==1.2.4 18:53:37 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:53:37 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:53:37 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:53:37 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:53:37 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:53:37 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:53:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:39 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:53:39 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:53:39 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:53:39 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:53:39 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:53:39 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:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:53:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:40 INFO - Downloading docopt-0.6.1.tar.gz 18:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:40 INFO - Running setup.py install for blobuploader 18:53:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:53:40 INFO - Running setup.py install for requests 18:53:41 INFO - Running setup.py install for docopt 18:53:41 INFO - Successfully installed blobuploader requests docopt 18:53:41 INFO - Cleaning up... 18:53:41 INFO - Return code: 0 18:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:41 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 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:41 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:53:41 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:53:41 INFO - Using env: {'DISPLAY': ':0', 18:53:41 INFO - 'HOME': '/home/cltbld', 18:53:41 INFO - 'LANG': 'en_US.UTF-8', 18:53:41 INFO - 'LANGUAGE': 'en_US:en', 18:53:41 INFO - 'LOGNAME': 'cltbld', 18:53:41 INFO - 'MAIL': '/var/mail/cltbld', 18:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:41 INFO - 'MOZ_NO_REMOTE': '1', 18:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:41 INFO - 'NO_EM_RESTART': '1', 18:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:41 INFO - 'PWD': '/builds/slave/test', 18:53:41 INFO - 'SHELL': '/bin/bash', 18:53:41 INFO - 'SHLVL': '1', 18:53:41 INFO - 'TERM': 'linux', 18:53:41 INFO - 'TMOUT': '86400', 18:53:41 INFO - 'USER': 'cltbld', 18:53:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:41 INFO - '_': '/tools/buildbot/bin/python'} 18:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:41 INFO - Running setup.py (path:/tmp/pip-8LYAcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:41 INFO - Running setup.py (path:/tmp/pip-744y4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:41 INFO - Running setup.py (path:/tmp/pip-sa2yf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:41 INFO - Running setup.py (path:/tmp/pip-JARqqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:41 INFO - Running setup.py (path:/tmp/pip-0zNYwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:41 INFO - Running setup.py (path:/tmp/pip-Vh_EHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:41 INFO - Running setup.py (path:/tmp/pip-pUK8G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:41 INFO - Running setup.py (path:/tmp/pip-wljCw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:42 INFO - Running setup.py (path:/tmp/pip-EtD4zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:42 INFO - Running setup.py (path:/tmp/pip-GcNWkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:42 INFO - Running setup.py (path:/tmp/pip-Eb_QrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:42 INFO - Running setup.py (path:/tmp/pip-qjyhqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:42 INFO - Running setup.py (path:/tmp/pip-ggtH_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:42 INFO - Running setup.py (path:/tmp/pip-tL_3VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:42 INFO - Running setup.py (path:/tmp/pip-K8hEM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:42 INFO - Running setup.py (path:/tmp/pip-3z11r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:42 INFO - Running setup.py (path:/tmp/pip-NUcj4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:42 INFO - Running setup.py install for manifestparser 18:53:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:53:42 INFO - Running setup.py install for mozcrash 18:53:42 INFO - Running setup.py install for mozdebug 18:53:42 INFO - Running setup.py install for mozdevice 18:53:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozfile 18:53:43 INFO - Running setup.py install for mozhttpd 18:53:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozinfo 18:53:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozInstall 18:53:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozleak 18:53:43 INFO - Running setup.py install for mozlog 18:53:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for moznetwork 18:53:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozprocess 18:53:43 INFO - Running setup.py install for mozprofile 18:53:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:53:44 INFO - Running setup.py install for mozrunner 18:53:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:53:44 INFO - Running setup.py install for mozscreenshot 18:53:44 INFO - Running setup.py install for moztest 18:53:44 INFO - Running setup.py install for mozversion 18:53:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:53:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:53:44 INFO - Cleaning up... 18:53:44 INFO - Return code: 0 18:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 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 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:44 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:53:44 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:53:44 INFO - Using env: {'DISPLAY': ':0', 18:53:44 INFO - 'HOME': '/home/cltbld', 18:53:44 INFO - 'LANG': 'en_US.UTF-8', 18:53:44 INFO - 'LANGUAGE': 'en_US:en', 18:53:44 INFO - 'LOGNAME': 'cltbld', 18:53:44 INFO - 'MAIL': '/var/mail/cltbld', 18:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:44 INFO - 'MOZ_NO_REMOTE': '1', 18:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:44 INFO - 'NO_EM_RESTART': '1', 18:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:44 INFO - 'PWD': '/builds/slave/test', 18:53:44 INFO - 'SHELL': '/bin/bash', 18:53:44 INFO - 'SHLVL': '1', 18:53:44 INFO - 'TERM': 'linux', 18:53:44 INFO - 'TMOUT': '86400', 18:53:44 INFO - 'USER': 'cltbld', 18:53:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:44 INFO - '_': '/tools/buildbot/bin/python'} 18:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:44 INFO - Running setup.py (path:/tmp/pip-ATHZzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:44 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:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:44 INFO - Running setup.py (path:/tmp/pip-M108K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:44 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:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:44 INFO - Running setup.py (path:/tmp/pip-WRSylS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:44 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:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:44 INFO - Running setup.py (path:/tmp/pip-h2s1t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:44 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:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:44 INFO - Running setup.py (path:/tmp/pip-fnUo28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:45 INFO - Running setup.py (path:/tmp/pip-BztyDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:45 INFO - Running setup.py (path:/tmp/pip-D7xV_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:45 INFO - Running setup.py (path:/tmp/pip-SSCYJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:45 INFO - Running setup.py (path:/tmp/pip-NtxoWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:45 INFO - Running setup.py (path:/tmp/pip-ttqQQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:45 INFO - Running setup.py (path:/tmp/pip-rkMLod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:45 INFO - Running setup.py (path:/tmp/pip-L6oNqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:45 INFO - Running setup.py (path:/tmp/pip-iO9Lj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:45 INFO - Running setup.py (path:/tmp/pip-XA0Uhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:45 INFO - Running setup.py (path:/tmp/pip-3DXMtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:45 INFO - Running setup.py (path:/tmp/pip-8ooHF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:45 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:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:45 INFO - Running setup.py (path:/tmp/pip-Hbhsrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:45 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:53:45 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:53:45 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:53:45 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:53:45 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:53:45 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:53:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:45 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:53:45 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:53:45 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:53:45 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:53:45 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:53:45 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:53:47 INFO - Downloading blessings-1.6.tar.gz 18:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:53:48 INFO - Installing collected packages: blessings 18:53:48 INFO - Running setup.py install for blessings 18:53:48 INFO - Successfully installed blessings 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:53:48 INFO - Reading from file tmpfile_stdout 18:53:48 INFO - Current package versions: 18:53:48 INFO - argparse == 1.2.1 18:53:48 INFO - blessings == 1.6 18:53:48 INFO - blobuploader == 1.2.4 18:53:48 INFO - docopt == 0.6.1 18:53:48 INFO - functools32 == 3.2.3-2 18:53:48 INFO - jsonschema == 2.5.1 18:53:48 INFO - manifestparser == 1.1 18:53:48 INFO - mozInstall == 1.12 18:53:48 INFO - mozcrash == 0.17 18:53:48 INFO - mozdebug == 0.1 18:53:48 INFO - mozdevice == 0.48 18:53:48 INFO - mozfile == 1.2 18:53:48 INFO - mozhttpd == 0.7 18:53:48 INFO - mozinfo == 0.9 18:53:48 INFO - mozleak == 0.1 18:53:48 INFO - mozlog == 3.4 18:53:48 INFO - moznetwork == 0.27 18:53:48 INFO - mozprocess == 0.23 18:53:48 INFO - mozprofile == 0.28 18:53:48 INFO - mozrunner == 6.12 18:53:48 INFO - mozscreenshot == 0.1 18:53:48 INFO - mozsystemmonitor == 0.3 18:53:48 INFO - moztest == 0.7 18:53:48 INFO - mozversion == 1.4 18:53:48 INFO - psutil == 3.1.1 18:53:48 INFO - requests == 1.2.3 18:53:48 INFO - wsgiref == 0.1.2 18:53:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 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 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:48 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:53:48 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:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:48 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:53:48 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:53:48 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:53:48 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:53:48 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:53:48 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:53:48 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:53:48 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:53:48 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:53:48 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:53:48 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:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:53:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 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 0x7f73405bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', '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:53:48 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:53:48 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:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Running post-action listener: _resource_record_post_action 18:53:48 INFO - Running post-action listener: _start_resource_monitoring 18:53:48 INFO - Starting resource monitoring. 18:53:48 INFO - [mozharness: 2016-10-05 01:53:48.881325Z] Finished create-virtualenv step (success) 18:53:48 INFO - [mozharness: 2016-10-05 01:53:48.881827Z] Running install step. 18:53:48 INFO - Running pre-action listener: _resource_record_pre_action 18:53:48 INFO - Running main action method: install 18:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:53:49 INFO - Reading from file tmpfile_stdout 18:53:49 INFO - Detecting whether we're running mozinstall >=1.0... 18:53:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:53:49 INFO - Reading from file tmpfile_stdout 18:53:49 INFO - Output received: 18:53:49 INFO - Usage: mozinstall [options] installer 18:53:49 INFO - Options: 18:53:49 INFO - -h, --help show this help message and exit 18:53:49 INFO - -d DEST, --destination=DEST 18:53:49 INFO - Directory to install application into. [default: 18:53:49 INFO - "/builds/slave/test"] 18:53:49 INFO - --app=APP Application being installed. [default: firefox] 18:53:49 INFO - mkdir: /builds/slave/test/build/application 18:53:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:54:05 INFO - Reading from file tmpfile_stdout 18:54:05 INFO - Output received: 18:54:05 INFO - /builds/slave/test/build/application/firefox/firefox 18:54:05 INFO - Running post-action listener: _resource_record_post_action 18:54:05 INFO - [mozharness: 2016-10-05 01:54:05.359915Z] Finished install step (success) 18:54:05 INFO - [mozharness: 2016-10-05 01:54:05.360158Z] Running run-tests step. 18:54:05 INFO - Running pre-action listener: _resource_record_pre_action 18:54:05 INFO - Running main action method: run_tests 18:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:54:05 INFO - Python 2.7.3 18:54:05 INFO - Return code: 0 18:54:05 INFO - grabbing minidump binary from tooltool 18:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:05 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 0x1c39f60>, '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 0x1c3ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:54:05 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:54:05 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:54:05 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:54:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:05 INFO - Return code: 0 18:54:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:54:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:54:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:54:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:54:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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:54:05 INFO - Using env: {'DISPLAY': ':0', 18:54:05 INFO - 'HOME': '/home/cltbld', 18:54:05 INFO - 'LANG': 'en_US.UTF-8', 18:54:05 INFO - 'LANGUAGE': 'en_US:en', 18:54:05 INFO - 'LOGNAME': 'cltbld', 18:54:05 INFO - 'MAIL': '/var/mail/cltbld', 18:54:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:54:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:05 INFO - 'MOZ_NO_REMOTE': '1', 18:54:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:05 INFO - 'NO_EM_RESTART': '1', 18:54:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:05 INFO - 'PWD': '/builds/slave/test', 18:54:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:54:05 INFO - 'SHELL': '/bin/bash', 18:54:05 INFO - 'SHLVL': '1', 18:54:05 INFO - 'TERM': 'linux', 18:54:05 INFO - 'TMOUT': '86400', 18:54:05 INFO - 'USER': 'cltbld', 18:54:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007', 18:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:05 INFO - '_': '/tools/buildbot/bin/python'} 18:54:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:54:05 INFO - mozversion application_buildid: 20161004173300 18:54:05 INFO - mozversion application_changeset: 9dc03b80c67223e32853b309e6c95fdd182061ba 18:54:05 INFO - mozversion application_display_name: Nightly 18:54:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:05 INFO - mozversion application_name: Firefox 18:54:05 INFO - mozversion application_remotingname: firefox 18:54:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:54:05 INFO - mozversion application_vendor: Mozilla 18:54:05 INFO - mozversion application_version: 52.0a1 18:54:05 INFO - mozversion platform_buildid: 20161004173300 18:54:05 INFO - mozversion platform_changeset: 9dc03b80c67223e32853b309e6c95fdd182061ba 18:54:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:54:05 INFO - mozversion platform_version: 52.0a1 18:54:05 INFO - using testdate: 1475632445 18:54:05 INFO - actual date: 1475632445 18:54:05 INFO - starting webserver on 'localhost:50823' 18:54:05 INFO - SUITE-START | Running 2 tests 18:54:05 INFO - TEST-START | dromaeo_css 18:54:05 INFO - operating with platform_type : linux_ 18:54:05 INFO - Initialising browser for dromaeo_css test... 18:54:05 INFO - TEST-INFO | started process 21054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYpHggL/profile http://localhost:50823/getInfo.html) 18:54:10 INFO - PROCESS | 21054 | __metrics Screen width/height:1600/1200 18:54:10 INFO - PROCESS | 21054 | colorDepth:24 18:54:10 INFO - PROCESS | 21054 | Browser inner width/height: 1024/697 18:54:10 INFO - PROCESS | 21054 | __metrics 18:54:10 INFO - PROCESS | 21054 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:54:10 INFO - PROCESS | 21054 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:54:11 INFO - PROCESS | 21054 | console.error: PushService: 18:54:11 INFO - PROCESS | 21054 | stateChangeProcessEnqueue: Error transitioning state 18:54:11 INFO - PROCESS | 21054 | UnknownError 18:54:12 INFO - TEST-INFO | 21054: exit 0 18:54:12 INFO - Browser initialized. 18:54:12 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:12 INFO - TEST-INFO | started process 21135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYpHggL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:24 INFO - PROCESS | 21135 | RSS: Main: 175742976 18:54:24 INFO - PROCESS | 21135 | 18:55:15 INFO - PROCESS | 21135 | 1475632515394 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:57:28 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:50823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50823/tests/dromaeo/cssquery-ext.html) 18:57:30 INFO - PROCESS | 21135 | RSS: Main: 316325888 18:57:30 INFO - PROCESS | 21135 | 19:00:33 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:50823/tests/dromaeo/cssquery-ext.html (next: http://localhost:50823/tests/dromaeo/cssquery-jquery.html) 19:00:33 INFO - PROCESS | 21135 | RSS: Main: 275320832 19:00:33 INFO - PROCESS | 21135 | 19:03:36 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:50823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50823/tests/dromaeo/cssquery-mootools.html) 19:03:36 INFO - PROCESS | 21135 | RSS: Main: 219996160 19:03:36 INFO - PROCESS | 21135 | 19:06:38 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:50823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50823/tests/dromaeo/cssquery-prototype.html) 19:06:39 INFO - PROCESS | 21135 | RSS: Main: 219213824 19:06:39 INFO - PROCESS | 21135 | 19:09:42 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:50823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50823/tests/dromaeo/cssquery-yui.html) 19:09:43 INFO - PROCESS | 21135 | RSS: Main: 220000256 19:09:43 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:50823/tests/dromaeo/cssquery-yui.html (next: http://localhost:50823/tests/dromaeo/cssquery-dojo.html) 19:12:46 INFO - PROCESS | 21135 | RSS: Main: 306151424 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | __start_tp_report 19:12:46 INFO - PROCESS | 21135 | _x_x_mozilla_page_load 19:12:46 INFO - PROCESS | 21135 | _x_x_mozilla_page_load_details 19:12:46 INFO - PROCESS | 21135 | |i|pagename|runs| 19:12:46 INFO - PROCESS | 21135 | |0;dojo.html;2567.48650269946;2588.2105957682925;2601.336659151916;2622.61972014058;2638.788896888249;4540;4623.653226008055;4671.322658214561;4680.882977925549;4689.906201875965;4639.721616703;4666.696664716791;4670.836520721776;4685.2035154023815;4775.188218002939;4268.7225330353585;4328.134373125372;4344.60898519134;4381.868543943687;4383.298672212447;4317.071829556645;4337.067530480946;4346.8043938022865;4352.97823510882;4372.256716358211;4370.278903980855;4375.474943006843;4420.823167073313;4429.734215947037;4456.086502267044;4181.0592616661315;4237.0890258594245;4248.065425606362;4301.698881078294;4334.111507141029;4201.76890271035;4229.661627069827;4255.361695745632;4262.7655478948645;4313.331433627793;4614.215583350805;4625.1443482955765;4632.119897219518;4637.234856248715;4674.368960190365;4822.7829747661435;4947.826826061107;4954.479779623124;4960.454350021495;4961.5286547777905;4896.1186986342445;4932.778024988848;5003.624728145403;5007.098722229997;5088.313077734496;4643.210654188796;4651.116287905287;4664.930026049612;4669.41632295963;4726.243800991825;5144.845654630367;5152.690838549699;5153.871153221199;5217.921731174036;5220.738963051832;4751.762411879461;4796.544328288807;4853;4893.363862697826;4903.607711383081;5032.144535428986;5032.597392208614;5032.924506132338;5034.84895453137;5082.390113186441;5004.874878128003;5006.949930500721;5007.974960125249;5008.073506401327;5055.418626857885;4789.616830653539;4844.903101937942;4853.587445067138;4877.512248775094;5044.4198917125;4238.427812245369;4255.744655320629;4255.87232383029;4257.467816522934;4264.57354264571;3647.744657873923;3661.5972243053243;3688.170161713647;3719.1445967427644;3735.028892487973;4335.523092459827;4338.566143385699;4374.278244089754;4390.538993405647;4392.780360981938;5020.497950205024;5025.597952163818;5029.622778291643;5034.270030845507;5084.898302033938;4147.585241475828;4257.10600773841;4263.786810659517;4329.891752706208;4334.783260836945;4502.302143167814;4526.479454862733;4535.138323718483;4579.335996280587;4587.288970209623;4684.110019096361;4723.480417154179;4725.078609671219;4726.71639701619;4764.547368000034;4856.73287969151;4864.1001414736975;4991.700497970133;4993.425756038102;5031.295618613324;4679.836205732783;4706.458757242824;4741.881452963704;4776.808927642995;4805;4954.083494553519;4958.033183529177;4960.7767650456535;4969.3291405659775;5023.497650234947;4811.855644330676;5025.447200807835;5027.446980832033;5035.395752509722;5085.110105731556;4734.124187025412;4753.809847606195;4789.425268967746;4805.879853003703;4886.120498310338;4829.879253018703;4830.686005409637;4839.516048395273;4841.467438581823;4898.093852637274;4764.094821983812;4768.284757286435;4774.140654682191;4777.904441911072;4825.203841366135;4730.881727956828;4787.976060119677;4834.63740219492;4888.877778055577;4909.77905994224;4775.498572649822;4779.617630589614;4782.2826576012485;4832.637552183671;4837.903241935212 19:12:46 INFO - PROCESS | 21135 | |1;ext.html;530.7744208711298;542.7666103575464;547.1519145324746;555.1395337227297;566.5948846574703;27575;28297.15108546744;38011.049723756885;38832.80583597085;38977;39156.80421597888;39658.80170599143;39899;39909.40135897964;39969.400458993136;7659.080910290759;7792;7797.0643522777345;7802.60986950653;7807.570583617899;7293.452991025668;7462.440316976222;7493.550386976799;9722.465264410455;9988.101070903616;10146;10209.744756381077;10210.64262750804;10210.744731381701;10221.591136354537;9593.088656577649;9643.566039528203;9644.614215431375;9654.22766178704;9654.662086826998;9713.271504637181;9761.804763904682;9768.51157442125;9772.169365603932;9777;37764.62235377639;37892.81053594742;37958.810205948794;37997.43003854944;38033.23933521314;2890.6675732290846;2907;2910.3160757222035;3053.3587946531256;3241.8379081045855;27698.446031079468;28234.576481352797;28559.714402855912;28608;29390.41219175626;3405.897823065312;3482.8084455354947;3492.3364560733635;3497.0732755819727;3526.682598566141;242924;243157;243312;243572;244065;52458.327917046205;52954.735226324396;53006;53016;53027.20459193115;32265.193370165933;33356.3328733424;33384.66615333864;34967;35004;14392.856071439151;14571.271436428136;14581.343839527246;14585.562433127023;14589.489367872073;9631.470269135265;9631.614735410505;9635.518224088768;9654.855177172349;9679.370840895319;14960.177190254422;17070.658586828442;17669.7349539757;17922.820771792376;18400.26398944027;6565.901511477332;6652.567583107082;6897.655117244118;6956.756513522104;7017.3684368407085;726.90963554668;779.859625267446;814.9975530098012;859.9699010534601;920.3603495570514;26205.868970655025;27259.863700681766;27269.45461090767;27636;27750.722492775218;889.7375274294099;891.5453118909273;894.7360528644066;922.1055576091181;969.2488321550713;14101.435942562182;14899.70200595982;14918.627034324229;15043.924780376028;15122.54632361031;348686;353967;354747.7878318273;355712;357750;48525.993211120476;49012;49012.26481602779;49057;49452.50547494479;1052.7947050325267;1068.4764465412047;1126.4367816091954;1148.3970915269551;1163.6392718257368;25658.358541036625;28599.714002859706;29244.41511169722;29281;29747.85126074356;41447.171056579304;41994.58005419907;42014.57985420229;42036;42052.57947420487;284017;285026;285249;285347;285519;21573.568528629654;22183;22325.888370558045;22342.77657223407;25555.87222063878;40675.93240676027;41202.175956481304;41687;41858.37212441755;42423;35260.64739352574;35278.29443411169;35333.646663533036;35501.28997420089;35758.46362304516;35721.1069723259;35962.4605630921;36277.09307267339;36324.63675363318;36371.45442818307;35386;35527.64472355243;35876.461853072746;36213.456798148574;36400.27199456049;30351.696483034888;32681.34637307288;32845;32909.341813163126;33175.83412082924;25129.24612261635;25569.74430255748;25612.231633051037;25617.871910640326;25751.871240643675 19:12:46 INFO - PROCESS | 21135 | |2;jquery.html;329;343.72306879941016;350.9964900350997;352.77775001748904;376.625257868421;12199.695007624814;15780.44939888526;16141.515754527369;16639;17730;16041.518754437357;16677.1661416929;16958.915205423957;17143.57141071474;17210.741838872425;3736.9065773355746;4862.854114376565;5025.623078269126;5070.543651071403;5101.897962040757;3638.2541578976247;3818.9045273868237;4884.19410797218;5534.197541356501;5826.650400975955;5884.235049443566;5898.085796701518;5902.675352855591;5903.970480147594;5909.11363295507;5610.859728506779;5779.393163717791;5821.941780582203;5841.357450680422;5886.764529418818;4961.975190124026;5141;5144.408393034774;5146.073706732786;5153.304303918961;20428;20465.4883627909;20528;20826.687599686018;20826.895865520575;1765.62921786425;1886.6132442849182;1920.807919208082;1956.2859556261863;2026.7973202679761;12556.497740090386;13225.86774132256;13562.864371356358;13801.378937947817;13820.516281930084;1607.3570571771268;1682.806477255119;1834.7431359609532;1836.9816301836945;1856.8885866848032;62170.68914655443;65260.3473965259;65731.67134164298;66268.33731662718;66367;8464.492130472192;8820.603072861737;8993.14565116313;9019.368644194974;9146.679866204784;12077.637670869888;12087.274763514217;12104.87895121055;12106.394680265952;12120.636380908587;6802.183737951477;6897.655117244118;6951.65241737911;7066.611336376446;7104.68028938699;6776.356246156607;6787.728490860311;6840.828979275558;6992.895106573405;7072.575645461186;3823.6941044716355;3847;3896.357101078347;3896.4155376693157;3940.802959851996;1620.376155180264;1667.2164082881027;1677.4296739108518;1737.37454516374;1825.762650855407;795.9243871832167;842.2588122452325;884.3146561414954;922.2345453273766;922.847730124522;16305;16698.6660266794;17168.742468862976;17632.118394080244;17745.822541774418;814.8696208606594;819.3772732723173;819.8360327934437;824.1552408780927;835.5028757889046;9307.767305817273;9889.505524723734;9893.109620134079;9903.702888913343;10029.64896228643;347490;357062;357262;358666;359162;73310.63685128813;73402;73548.89676654854;73652.26347736454;75302;888.2893685052062;912.9178373946377;932.3147486597345;934.5560858592114;943.4669411782321;14605.634859128606;14832.035917665316;14948.177850218342;15481.690366192388;15617;35442.64557354394;35632;36218.275634486636;36331;36448.08879778027;48567.757161213965;48776.5122348772;48793.512064878894;48905.5109448901;48959;7423.628818558943;7567.470277080552;7624.466287360054;7689.385229101951;7861.410394220571;10638.361698298128;10804.297720648132;10805.297655652672;11833.526658933546;12243.020558355132;9483.193928516153;10040.246981476565;10280.434576098387;10447.63433279862;10562.630307939186;9561.043895610383;9805.558749856416;9906.157976572073;10062.547185376528;10078.899211008089;9607.711768646952;10279.434631095362;10448.843267351147;10680.359178449318;11256.324620522795;7597.164311925573;7600.733974311093;7616.885746713914;7756.457048006585;7955.721549745731;10278.074973252444;10279.897201028192;10522.1056210223;10629.787404252027;11016.889831101907 19:12:46 INFO - PROCESS | 21135 | |3;mootools.html;1344.0121510689644;1361.6391656211104;1419.16978567538;1628.1045425016252;1667.458076125259;7059.752908648192;7649.502782319159;7667.539947603148;7670;7674.155842857282;6400.935990640092;6643.468522518187;7014.684339204735;7277.454190935675;7281.854362912739;2082.28161284357;2112.915483380663;2115.629764791163;2116.9259075932346;2118;2045.1103769860083;2050.897455127245;2076.636588596997;2084.5414008918015;2096.727425434691;1722.4229882989214;1802.5223315821318;2005.2179649936536;2078.449210959097;2078.6570215914358;2078.1583458699174;2102.516421223112;2107.336189100436;2108.325335892515;2108.8523803333774;2036.378904434147;2078.542720601465;2080.3966849613594;2083.468715477559;2084.6560317547587;7239.276072392771;7271.418286537064;7291.744788932362;7292.635368231568;7295.927040729578;4301.075268817188;4500.797464114123;4510.797014134372;4511.323301504801;4513.458384993789;2844.317363832686;2923.6199294091844;2976.1815500737252;2977.523596224615;2984.492636251842;885.7785553611598;942.236788201559;951.8286708392486;952.9666461673808;963.6386355116831;10187.286889917708;10210.693679189637;10263.127634151106;10288.331258468175;10292.485375731183;3667.7799332040163;3859.826307816155;3981.0843505993203;3986.202759448122;4014.8193331300163;8626.266767324847;8695.391322607484;8702.82594348122;8704.129587041372;8711.259542938795;4481.887952801206;4489.5959363656775;4496.437945256843;4499.257622492252;4510.368548403226;4046.4537287466405;4107.712460127762;4108.5275193352545;4114.177164567099;4115.382692596135;3358.311546133086;3460.169559305799;3501.3347463981763;3517.577890653087;3628.4738712886483;1078.1051727066515;1106.0930037369442;1111.0611533254548;1125.2460851229696;1127.9943600281947;558.0162522233418;684.4045680258108;807.2734538914906;845.5560830564003;865.8831057807241;5001.199808030698;5113.258577506241;5220.791168353299;5256.448072952361;5315.840524784263;803.2569872867574;838.8322335532796;861.9482831030158;862.3833958719421;868.4398562927003;3408.897733068012;3571.267890082579;3572.3034008368118;3588.820558972041;3681.9447708284397;8596.484210947363;8943.3739638226;8951.955240223888;9042.954785226031;9106.95446522763;8930.821383572293;8976.461412315282;9005;9012.143846334588;9012.504312262889;6851.862962740817;6915.585064896122;6990.755323563651;7005;7010.404115650125;4912.140375434214;4976.850694479172;5027.698338099725;5061.215511595708;5236.423993360803;8247.21651443112;8292.37807164477;8376.539290338846;8393.160683931557;8444.155584441507;8395.83208335842;8487;8493.915060849313;8524.232819046316;8526.957365213382;6318.336574659595;6335.4931605472375;6545.705443254969;6609.933900660932;6747.628880411625;7367.77896663101;7420.962895185489;7428.554286742813;7436.293552112541;7437.51656142349;6549.836254093686;6602.570832895846;6645.435138013323;6666.966665166643;6770.424513916372;6435.549511534147;6450.129232553545;6466.32103629131;6502.252240992347;6591.736330546724;6151.938480615316;6153.077038444269;6208.441240288215;6214.4407003369915;6217.533684973736;4399.076193999168;4428.844990425319;4523.932141017822;4550.522195169459;4593.793279302507;4388.429504164438;4408.250597398386;4535.455745310584;4556.840510582114;4714.15145273854 19:12:46 INFO - PROCESS | 21135 | |4;prototype.html;281.53687184581366;282.8034516011373;287.3950334545782;293.5391435446349;297.40370557033145;4712.269598212274;4768.761561921908;4783.30642056902;4783.402074740658;4798.328234047236;4687.320338550908;4709.128811169936;4728.716277023381;4735.952640473594;4743.217369134098;3467.497212904134;3595.2989167112423;3659.3047321009058;3707.90730231745;3745.681617062553;3726.2920045191327;3726.3851464508325;3730.7388482806214;3750.8687195948146;3751.1747415568666;3694.6305369463107;3705.8702945396917;3706.666400023997;3708.7033037357082;3710.3506886294927;3514.472829075646;3568.7680300780626;3648.2703459308245;3701.611330810253;3703.4445532876257;3254.576905002358;3258.1691668624585;3260.3153337798853;3262.951055734166;3266.5263536787033;4580.977095114503;4585.449746030465;4596.701214421086;4599.724016559017;4638.721676699409;3920.2551515212017;4150.418941348214;4224.894377640553;4226.949929284295;4239.978800106011;4942.431620363633;4946.516045186466;4949.529794669501;4954.950450495485;4955.430125535573;3447.6035255945635;3451.4650229214512;3454.913627159316;3460.913477163091;3475.9131021724406;5007.7575842234055;5199.662021968597;5205.115130427798;5220.321358223407;5238;3527.400341941876;3544.1848374873925;3553.466979953028;3562.287542491512;3588.8385022674042;3604.5854726706766;3608.7654302470255;3620.2035552178477;3622.3298689742483;3625.1118475973553;4174.874753757392;4178.101708132705;4181.644560212416;4188.518320393194;4194.496660400771;4657.464391594942;4910.705357678551;5012.573931215815;5021;5029.17018691919;1239.7706424311532;1253.260576260011;1256.8617452080264;1258.1130303136267;1260.710036691566;772.4129661457333;797.9148358232799;811.6996711216769;813.2558708781517;813.9784570364155;4024.2957482441043;4267.5732426757695;4342;4396.9120617588105;4463.8214471421425;4994.950050499521;5109;5122;5126.333576635088;5147.301390541113;4438.889027774331;4442.422485076984;4444.533324000933;4457.487388950312;4461;2637.643918071074;2684.6644169478814;2708.404151086758;2729.495043416974;2729.5905614158037;4869.099216644861;4870.439899411542;4873.221274234878;4876.244182151772;4879.194932836042;5247.2129180623215;5265.7103859287345;5291.232771248147;5294.947050529446;5295.4846447936925;4731.668783185213;4805.1590971579835;4818.614510839125;4853.51464853526;4878.634102442402;5084.339035925306;5129.87175320605;5147.150720131136;5155.252488389237;5158.535731784007;4986.750662466935;5054.368203974504;5055.0538042854505;5059.266406370982;5093.643444958817;4593.816247350069;4756.191447453872;4812.879678007937;4865.051314993542;4879.316895634685;3519.8768043118366;3543.36219480496;3543.6002778902703;3550.538430004083;3579.6957258632265;5104.821331253388;5126.743947732829;5129.2819005340025;5131.461196574455;5138.640295179302;4757.286407038971;4894.461609222912;4898.828541001048;4933.506649335038;4982.526659967298;4933.876653083558;4935.950640493693;4938.901221975612;4945.23348880924;4948.169177404384;4890.559849613552;4896.4124305083615;4900;4910.9263361050325;4919.803207871645;4722.693024953367;4739.810407583658;4932;4939.456659767351;4986.083141362344;4683.742394168354;4748.216544270295;4827.831025914076;4827.95172048275;4837.323634038086 19:12:46 INFO - PROCESS | 21135 | |5;yui.html;589.7778437484537;603.5714642603748;660.8281846719857;716.9962053125627;746.925307469253;12780;13507.25710085945;14070.4371825127;14083.507077252298;14317.069390489636;12663.746725065494;12873.163244389109;12896.74206515869;12899.484020639187;12901.677458063554;754.6151462754008;774.0711146624045;775.0118598786536;775.0505630602495;775.7284950267418;602.1900543768625;624.1947887225474;733.9376153026999;760.5664771080486;768.0054329643126;813.4834380168577;814.861473549498;815.604431850552;815.7552734179752;815.8776183572481;807.8828569857396;809.4091313341264;809.4172196018857;809.5345176523523;809.6194788449449;465.6530884491042;476.43304467683345;566.4590316247974;584.1004852527103;596.588354035714;12548.247105173628;12573.308468034254;12578.182418142791;12578.74842503154;12583.559575414816;11713.837263938774;11715.02221247195;12055.93972030143;12417.813732794015;12725.936370318183;11015.118790496741;11107.555697772079;11189.608363707232;11386.601468948547;11415.828762568568;4010.258102251093;4031.9395209071886;4064.166845796605;4111.7944102794745;4117.485314335708;60982.69508652473;61817.07274390888;62569.37430625681;62592.68703656452;62843.6857815708;9875.358101723365;9877;9890.456024918554;9973.351732137387;10030.398176109456;16647.16764161787;17351.82648173502;17391.565210869576;18332.63334733298;18424.631507369777;6713.69788359525;6749.0888730020815;6970.198427180838;7001.089858318386;7010.964945175241;3659.268146370683;3753.11801726594;3764.7176461765475;3770.4155855842387;3790.507234059555;2718.8912443502436;2814.9718502815117;2831.5327970884573;2837.092130518214;2842.7725781937397;481.26126395982;483.4126536258463;488.19447910946514;489.45670305960357;493.1247036510223;579.5305802300151;581.4272941152961;607.3289015637745;625.871696302257;629.568745409396;8545.273651739548;8781.20969112783;8843.248323892412;8903.688370906988;9026;470.543572734447;558.1293182635102;575.3929604267538;584.1850618387326;591.204829504316;3860.8069596520063;4203.864956461738;4283.571642835692;4378.124375124988;4393.319035549495;75789.62105189438;101400;102688.48655756674;104313;105125;86670.56664716636;87815.56092219499;88396;89615;89980.5500972491;71977.28022719706;74115.62942185254;74640;74692.25307746962;78210.6089469549;8079.272865442138;8347.332213423033;8410.744793715923;8510.957445212734;8551.74344769658;43908;44459.55540444684;45123.774381127885;45382.546174537834;45405;61861.69069154625;65249.347506524326;65931.67034164799;65983.6700816512;67389.66305168443;9691.418514889128;10331.431771252654;11136.498857551267;11185.944070279596;11339.829902551302;12946.226052971411;13045.412956416794;13440;13529.59411217665;14147.787783183467;12151.696207594881;12205.572804951784;12254.080943929419;12346.81479777786;12627.684307892376;12012.519499219934;12402;12598.433070511666;12656.101584762358;12668.176568523017;12019.819702704292;12413.379331033593;12441.564545241235;12568.120231583702;13168.144070635379;9843.409395436296;10145.28982971185;10184.134348580454;10565.154787617126;10663.093637040938;9757;9995.350302230332;10081.294309398272;10082.29423940317;10169.593216271267 19:12:46 INFO - PROCESS | 21135 | __end_tp_report 19:12:46 INFO - PROCESS | 21135 | __start_cc_report 19:12:46 INFO - PROCESS | 21135 | _x_x_mozilla_cycle_collect,1410 19:12:46 INFO - PROCESS | 21135 | __end_cc_report 19:12:46 INFO - PROCESS | 21135 | __startTimestamp1475633566376__endTimestamp 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | ------- Summary: start ------- 19:12:46 INFO - PROCESS | 21135 | Number of tests: 6 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | [#0] dojo.html Cycles:165 Average:4615.98 Median:4741.88 stddev:479.81 (10.1%) stddev-sans-first:453.57 19:12:46 INFO - PROCESS | 21135 | Values: 2567.5 2588.2 2601.3 2622.6 2638.8 4540.0 4623.7 4671.3 4680.9 4689.9 4639.7 4666.7 4670.8 4685.2 4775.2 4268.7 4328.1 4344.6 4381.9 4383.3 4317.1 4337.1 4346.8 4353.0 4372.3 4370.3 4375.5 4420.8 4429.7 4456.1 4181.1 4237.1 4248.1 4301.7 4334.1 4201.8 4229.7 4255.4 4262.8 4313.3 4614.2 4625.1 4632.1 4637.2 4674.4 4822.8 4947.8 4954.5 4960.5 4961.5 4896.1 4932.8 5003.6 5007.1 5088.3 4643.2 4651.1 4664.9 4669.4 4726.2 5144.8 5152.7 5153.9 5217.9 5220.7 4751.8 4796.5 4853.0 4893.4 4903.6 5032.1 5032.6 5032.9 5034.8 5082.4 5004.9 5006.9 5008.0 5008.1 5055.4 4789.6 4844.9 4853.6 4877.5 5044.4 4238.4 4255.7 4255.9 4257.5 4264.6 3647.7 3661.6 3688.2 3719.1 3735.0 4335.5 4338.6 4374.3 4390.5 4392.8 5020.5 5025.6 5029.6 5034.3 5084.9 4147.6 4257.1 4263.8 4329.9 4334.8 4502.3 4526.5 4535.1 4579.3 4587.3 4684.1 4723.5 4725.1 4726.7 4764.5 4856.7 4864.1 4991.7 4993.4 5031.3 4679.8 4706.5 4741.9 4776.8 4805.0 4954.1 4958.0 4960.8 4969.3 5023.5 4811.9 5025.4 5027.4 5035.4 5085.1 4734.1 4753.8 4789.4 4805.9 4886.1 4829.9 4830.7 4839.5 4841.5 4898.1 4764.1 4768.3 4774.1 4777.9 4825.2 4730.9 4788.0 4834.6 4888.9 4909.8 4775.5 4779.6 4782.3 4832.6 4837.9 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | [#1] ext.html Cycles:180 Average:44578.72 Median:195619.82 stddev:78071.12 (39.9%) stddev-sans-first:78220.08 19:12:46 INFO - PROCESS | 21135 | Values: 530.8 542.8 547.2 555.1 566.6 27575.0 28297.2 38011.0 38832.8 38977.0 39156.8 39658.8 39899.0 39909.4 39969.4 7659.1 7792.0 7797.1 7802.6 7807.6 7293.5 7462.4 7493.6 9722.5 9988.1 10146.0 10209.7 10210.6 10210.7 10221.6 9593.1 9643.6 9644.6 9654.2 9654.7 9713.3 9761.8 9768.5 9772.2 9777.0 37764.6 37892.8 37958.8 37997.4 38033.2 2890.7 2907.0 2910.3 3053.4 3241.8 27698.4 28234.6 28559.7 28608.0 29390.4 3405.9 3482.8 3492.3 3497.1 3526.7 242924.0 243157.0 243312.0 243572.0 244065.0 52458.3 52954.7 53006.0 53016.0 53027.2 32265.2 33356.3 33384.7 34967.0 35004.0 14392.9 14571.3 14581.3 14585.6 14589.5 9631.5 9631.6 9635.5 9654.9 9679.4 14960.2 17070.7 17669.7 17922.8 18400.3 6565.9 6652.6 6897.7 6956.8 7017.4 726.9 779.9 815.0 860.0 920.4 26205.9 27259.9 27269.5 27636.0 27750.7 889.7 891.5 894.7 922.1 969.2 14101.4 14899.7 14918.6 15043.9 15122.5 348686.0 353967.0 354747.8 355712.0 357750.0 48526.0 49012.0 49012.3 49057.0 49452.5 1052.8 1068.5 1126.4 1148.4 1163.6 25658.4 28599.7 29244.4 29281.0 29747.9 41447.2 41994.6 42014.6 42036.0 42052.6 284017.0 285026.0 285249.0 285347.0 285519.0 21573.6 22183.0 22325.9 22342.8 25555.9 40675.9 41202.2 41687.0 41858.4 42423.0 35260.6 35278.3 35333.6 35501.3 35758.5 35721.1 35962.5 36277.1 36324.6 36371.5 35386.0 35527.6 35876.5 36213.5 36400.3 30351.7 32681.3 32845.0 32909.3 33175.8 25129.2 25569.7 25612.2 25617.9 25751.9 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | [#2] jquery.html Cycles:180 Average:23035.96 Median:3871.68 stddev:58827.20 (1519.4%) stddev-sans-first:58967.52 19:12:46 INFO - PROCESS | 21135 | Values: 329.0 343.7 351.0 352.8 376.6 12199.7 15780.4 16141.5 16639.0 17730.0 16041.5 16677.2 16958.9 17143.6 17210.7 3736.9 4862.9 5025.6 5070.5 5101.9 3638.3 3818.9 4884.2 5534.2 5826.7 5884.2 5898.1 5902.7 5904.0 5909.1 5610.9 5779.4 5821.9 5841.4 5886.8 4962.0 5141.0 5144.4 5146.1 5153.3 20428.0 20465.5 20528.0 20826.7 20826.9 1765.6 1886.6 1920.8 1956.3 2026.8 12556.5 13225.9 13562.9 13801.4 13820.5 1607.4 1682.8 1834.7 1837.0 1856.9 62170.7 65260.3 65731.7 66268.3 66367.0 8464.5 8820.6 8993.1 9019.4 9146.7 12077.6 12087.3 12104.9 12106.4 12120.6 6802.2 6897.7 6951.7 7066.6 7104.7 6776.4 6787.7 6840.8 6992.9 7072.6 3823.7 3847.0 3896.4 3896.4 3940.8 1620.4 1667.2 1677.4 1737.4 1825.8 795.9 842.3 884.3 922.2 922.8 16305.0 16698.7 17168.7 17632.1 17745.8 814.9 819.4 819.8 824.2 835.5 9307.8 9889.5 9893.1 9903.7 10029.6 347490.0 357062.0 357262.0 358666.0 359162.0 73310.6 73402.0 73548.9 73652.3 75302.0 888.3 912.9 932.3 934.6 943.5 14605.6 14832.0 14948.2 15481.7 15617.0 35442.6 35632.0 36218.3 36331.0 36448.1 48567.8 48776.5 48793.5 48905.5 48959.0 7423.6 7567.5 7624.5 7689.4 7861.4 10638.4 10804.3 10805.3 11833.5 12243.0 9483.2 10040.2 10280.4 10447.6 10562.6 9561.0 9805.6 9906.2 10062.5 10078.9 9607.7 10279.4 10448.8 10680.4 11256.3 7597.2 7600.7 7616.9 7756.5 7955.7 10278.1 10279.9 10522.1 10629.8 11016.9 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | [#3] mootools.html Cycles:180 Average:4924.28 Median:5167.02 stddev:2715.18 (52.5%) stddev-sans-first:2709.46 19:12:46 INFO - PROCESS | 21135 | Values: 1344.0 1361.6 1419.2 1628.1 1667.5 7059.8 7649.5 7667.5 7670.0 7674.2 6400.9 6643.5 7014.7 7277.5 7281.9 2082.3 2112.9 2115.6 2116.9 2118.0 2045.1 2050.9 2076.6 2084.5 2096.7 1722.4 1802.5 2005.2 2078.4 2078.7 2078.2 2102.5 2107.3 2108.3 2108.9 2036.4 2078.5 2080.4 2083.5 2084.7 7239.3 7271.4 7291.7 7292.6 7295.9 4301.1 4500.8 4510.8 4511.3 4513.5 2844.3 2923.6 2976.2 2977.5 2984.5 885.8 942.2 951.8 953.0 963.6 10187.3 10210.7 10263.1 10288.3 10292.5 3667.8 3859.8 3981.1 3986.2 4014.8 8626.3 8695.4 8702.8 8704.1 8711.3 4481.9 4489.6 4496.4 4499.3 4510.4 4046.5 4107.7 4108.5 4114.2 4115.4 3358.3 3460.2 3501.3 3517.6 3628.5 1078.1 1106.1 1111.1 1125.2 1128.0 558.0 684.4 807.3 845.6 865.9 5001.2 5113.3 5220.8 5256.4 5315.8 803.3 838.8 861.9 862.4 868.4 3408.9 3571.3 3572.3 3588.8 3681.9 8596.5 8943.4 8952.0 9043.0 9107.0 8930.8 8976.5 9005.0 9012.1 9012.5 6851.9 6915.6 6990.8 7005.0 7010.4 4912.1 4976.9 5027.7 5061.2 5236.4 8247.2 8292.4 8376.5 8393.2 8444.2 8395.8 8487.0 8493.9 8524.2 8527.0 6318.3 6335.5 6545.7 6609.9 6747.6 7367.8 7421.0 7428.6 7436.3 7437.5 6549.8 6602.6 6645.4 6667.0 6770.4 6435.5 6450.1 6466.3 6502.3 6591.7 6151.9 6153.1 6208.4 6214.4 6217.5 4399.1 4428.8 4523.9 4550.5 4593.8 4388.4 4408.3 4535.5 4556.8 4714.2 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | [#4] prototype.html Cycles:180 Average:4109.93 Median:4717.48 stddev:1206.52 (25.6%) stddev-sans-first:1175.19 19:12:46 INFO - PROCESS | 21135 | Values: 281.5 282.8 287.4 293.5 297.4 4712.3 4768.8 4783.3 4783.4 4798.3 4687.3 4709.1 4728.7 4736.0 4743.2 3467.5 3595.3 3659.3 3707.9 3745.7 3726.3 3726.4 3730.7 3750.9 3751.2 3694.6 3705.9 3706.7 3708.7 3710.4 3514.5 3568.8 3648.3 3701.6 3703.4 3254.6 3258.2 3260.3 3263.0 3266.5 4581.0 4585.4 4596.7 4599.7 4638.7 3920.3 4150.4 4224.9 4226.9 4240.0 4942.4 4946.5 4949.5 4955.0 4955.4 3447.6 3451.5 3454.9 3460.9 3475.9 5007.8 5199.7 5205.1 5220.3 5238.0 3527.4 3544.2 3553.5 3562.3 3588.8 3604.6 3608.8 3620.2 3622.3 3625.1 4174.9 4178.1 4181.6 4188.5 4194.5 4657.5 4910.7 5012.6 5021.0 5029.2 1239.8 1253.3 1256.9 1258.1 1260.7 772.4 797.9 811.7 813.3 814.0 4024.3 4267.6 4342.0 4396.9 4463.8 4995.0 5109.0 5122.0 5126.3 5147.3 4438.9 4442.4 4444.5 4457.5 4461.0 2637.6 2684.7 2708.4 2729.5 2729.6 4869.1 4870.4 4873.2 4876.2 4879.2 5247.2 5265.7 5291.2 5294.9 5295.5 4731.7 4805.2 4818.6 4853.5 4878.6 5084.3 5129.9 5147.2 5155.3 5158.5 4986.8 5054.4 5055.1 5059.3 5093.6 4593.8 4756.2 4812.9 4865.1 4879.3 3519.9 3543.4 3543.6 3550.5 3579.7 5104.8 5126.7 5129.3 5131.5 5138.6 4757.3 4894.5 4898.8 4933.5 4982.5 4933.9 4936.0 4938.9 4945.2 4948.2 4890.6 4896.4 4900.0 4910.9 4919.8 4722.7 4739.8 4932.0 4939.5 4986.1 4683.7 4748.2 4827.8 4828.0 4837.3 19:12:46 INFO - PROCESS | 21135 | 19:12:46 INFO - PROCESS | 21135 | [#5] yui.html Cycles:180 Average:18058.51 Median:22935.33 stddev:25860.50 (112.8%) stddev-sans-first:25899.78 19:12:46 INFO - PROCESS | 21135 | Values: 589.8 603.6 660.8 717.0 746.9 12780.0 13507.3 14070.4 14083.5 14317.1 12663.7 12873.2 12896.7 12899.5 12901.7 754.6 774.1 775.0 775.1 775.7 602.2 624.2 733.9 760.6 768.0 813.5 814.9 815.6 815.8 815.9 807.9 809.4 809.4 809.5 809.6 465.7 476.4 566.5 584.1 596.6 12548.2 12573.3 12578.2 12578.7 12583.6 11713.8 11715.0 12055.9 12417.8 12725.9 11015.1 11107.6 11189.6 11386.6 11415.8 4010.3 4031.9 4064.2 4111.8 4117.5 60982.7 61817.1 62569.4 62592.7 62843.7 9875.4 9877.0 9890.5 9973.4 10030.4 16647.2 17351.8 17391.6 18332.6 18424.6 6713.7 6749.1 6970.2 7001.1 7011.0 3659.3 3753.1 3764.7 3770.4 3790.5 2718.9 2815.0 2831.5 2837.1 2842.8 481.3 483.4 488.2 489.5 493.1 579.5 581.4 607.3 625.9 629.6 8545.3 8781.2 8843.2 8903.7 9026.0 470.5 558.1 575.4 584.2 591.2 3860.8 4203.9 4283.6 4378.1 4393.3 75789.6 101400.0 102688.5 104313.0 105125.0 86670.6 87815.6 88396.0 89615.0 89980.6 71977.3 74115.6 74640.0 74692.3 78210.6 8079.3 8347.3 8410.7 8511.0 8551.7 43908.0 44459.6 45123.8 45382.5 45405.0 61861.7 65249.3 65931.7 65983.7 67389.7 9691.4 10331.4 11136.5 11185.9 11339.8 12946.2 13045.4 13440.0 13529.6 14147.8 12151.7 12205.6 12254.1 12346.8 12627.7 12012.5 12402.0 12598.4 12656.1 12668.2 12019.8 12413.4 12441.6 12568.1 13168.1 9843.4 10145.3 10184.1 10565.2 10663.1 9757.0 9995.4 10081.3 10082.3 10169.6 19:12:46 INFO - PROCESS | 21135 | -------- Summary: end -------- 19:12:46 INFO - PROCESS | 21135 | 19:12:47 INFO - TEST-INFO | 21135: exit 0 19:12:47 INFO - TEST-OK | dromaeo_css | took 1121783ms 19:12:47 INFO - TEST-START | kraken 19:12:47 INFO - operating with platform_type : linux_ 19:12:47 INFO - Initialising browser for kraken test... 19:12:47 INFO - TEST-INFO | started process 21441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Ho2uP/profile http://localhost:50823/getInfo.html) 19:12:51 INFO - PROCESS | 21441 | __metrics Screen width/height:1600/1200 19:12:51 INFO - PROCESS | 21441 | colorDepth:24 19:12:51 INFO - PROCESS | 21441 | Browser inner width/height: 1024/697 19:12:51 INFO - PROCESS | 21441 | __metrics 19:12:52 INFO - PROCESS | 21441 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:12:52 INFO - PROCESS | 21441 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:53 INFO - PROCESS | 21441 | console.error: PushService: 19:12:53 INFO - PROCESS | 21441 | stateChangeProcessEnqueue: Error transitioning state 19:12:53 INFO - PROCESS | 21441 | UnknownError 19:12:53 INFO - TEST-INFO | 21441: exit 0 19:12:53 INFO - Browser initialized. 19:12:53 INFO - Running cycle 1/1 for kraken test... 19:12:53 INFO - TEST-INFO | started process 21523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Ho2uP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:06 INFO - PROCESS | 21523 | RSS: Main: 175439872 19:13:06 INFO - PROCESS | 21523 | 19:13:08 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50823/tests/kraken/driver.html?testName=audio-beat-detection) 19:13:09 INFO - PROCESS | 21523 | RSS: Main: 242737152 19:13:09 INFO - PROCESS | 21523 | 19:13:12 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50823/tests/kraken/driver.html?testName=audio-dft) 19:13:13 INFO - PROCESS | 21523 | RSS: Main: 219471872 19:13:13 INFO - PROCESS | 21523 | 19:13:16 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50823/tests/kraken/driver.html?testName=audio-fft) 19:13:17 INFO - PROCESS | 21523 | RSS: Main: 301355008 19:13:17 INFO - PROCESS | 21523 | 19:13:19 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50823/tests/kraken/driver.html?testName=audio-oscillator) 19:13:19 INFO - PROCESS | 21523 | RSS: Main: 212889600 19:13:19 INFO - PROCESS | 21523 | 19:13:22 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:22 INFO - PROCESS | 21523 | RSS: Main: 214650880 19:13:22 INFO - PROCESS | 21523 | 19:13:25 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50823/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:26 INFO - PROCESS | 21523 | RSS: Main: 251064320 19:13:26 INFO - PROCESS | 21523 | 19:13:29 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50823/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:30 INFO - PROCESS | 21523 | RSS: Main: 245256192 19:13:30 INFO - PROCESS | 21523 | 19:13:33 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50823/tests/kraken/driver.html?testName=json-parse-financial) 19:13:34 INFO - PROCESS | 21523 | RSS: Main: 248029184 19:13:34 INFO - PROCESS | 21523 | 19:13:35 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:36 INFO - PROCESS | 21523 | RSS: Main: 211472384 19:13:36 INFO - PROCESS | 21523 | 19:13:38 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:38 INFO - PROCESS | 21523 | RSS: Main: 218292224 19:13:38 INFO - PROCESS | 21523 | 19:13:41 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:41 INFO - PROCESS | 21523 | RSS: Main: 228397056 19:13:41 INFO - PROCESS | 21523 | 19:13:44 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:45 INFO - PROCESS | 21523 | RSS: Main: 236146688 19:13:45 INFO - PROCESS | 21523 | 19:13:48 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:48 INFO - PROCESS | 21523 | RSS: Main: 232759296 19:13:48 INFO - PROCESS | 21523 | 19:13:50 INFO - PROCESS | 21523 | Cycle 1(1): loaded http://localhost:50823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50823/tests/kraken/driver.html?testName=ai-astar) 19:13:50 INFO - PROCESS | 21523 | RSS: Main: 284758016 19:13:50 INFO - PROCESS | 21523 | 19:13:50 INFO - PROCESS | 21523 | __start_tp_report 19:13:50 INFO - PROCESS | 21523 | _x_x_mozilla_page_load 19:13:50 INFO - PROCESS | 21523 | _x_x_mozilla_page_load_details 19:13:50 INFO - PROCESS | 21523 | |i|pagename|runs| 19:13:50 INFO - PROCESS | 21523 | |0;ai-astar;115;114;114;116;117;114;116;116;115;117 19:13:50 INFO - PROCESS | 21523 | |1;audio-beat-detection;156;134;128;168;129;127;127;131;166;131 19:13:50 INFO - PROCESS | 21523 | |2;audio-dft;161;159;163;161;161;159;162;160;160;159 19:13:50 INFO - PROCESS | 21523 | |3;audio-fft;76;78;77;101;77;76;76;75;107;77 19:13:50 INFO - PROCESS | 21523 | |4;audio-oscillator;84;84;126;83;84;84;111;83;83;114 19:13:50 INFO - PROCESS | 21523 | |5;imaging-gaussian-blur;118;118;118;117;117;118;117;118;117;118 19:13:51 INFO - PROCESS | 21523 | |6;imaging-darkroom;146;147;146;147;147;147;146;146;146;146 19:13:51 INFO - PROCESS | 21523 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;94 19:13:51 INFO - PROCESS | 21523 | |8;json-parse-financial;65;65;65;64;64;65;65;66;66;66 19:13:51 INFO - PROCESS | 21523 | |9;json-stringify-tinderbox;66;66;66;66;67;67;68;66;67;67 19:13:51 INFO - PROCESS | 21523 | |10;stanford-crypto-aes;84;83;83;83;83;83;89;84;98;84 19:13:51 INFO - PROCESS | 21523 | |11;stanford-crypto-ccm;140;143;141;138;141;152;138;137;182;141 19:13:51 INFO - PROCESS | 21523 | |12;stanford-crypto-pbkdf2;182;173;175;176;175;174;173;172;172;176 19:13:51 INFO - PROCESS | 21523 | |13;stanford-crypto-sha256-iterative;68;70;70;69;69;70;69;69;69;68 19:13:51 INFO - PROCESS | 21523 | __end_tp_report 19:13:51 INFO - PROCESS | 21523 | __start_cc_report 19:13:51 INFO - PROCESS | 21523 | _x_x_mozilla_cycle_collect,1929 19:13:51 INFO - PROCESS | 21523 | __end_cc_report 19:13:51 INFO - PROCESS | 21523 | __startTimestamp1475633630991__endTimestamp 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | ------- Summary: start ------- 19:13:51 INFO - PROCESS | 21523 | Number of tests: 14 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:1.17 (1.0%) stddev-sans-first:1.24 19:13:51 INFO - PROCESS | 21523 | Values: 115.0 114.0 114.0 116.0 117.0 114.0 116.0 116.0 115.0 117.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:132.50 stddev:16.72 (12.6%) stddev-sans-first:16.66 19:13:51 INFO - PROCESS | 21523 | Values: 156.0 134.0 128.0 168.0 129.0 127.0 127.0 131.0 166.0 131.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 19:13:51 INFO - PROCESS | 21523 | Values: 161.0 159.0 163.0 161.0 161.0 159.0 162.0 160.0 160.0 159.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.50 stddev:11.71 (15.3%) stddev-sans-first:12.22 19:13:51 INFO - PROCESS | 21523 | Values: 76.0 78.0 77.0 101.0 77.0 76.0 76.0 75.0 107.0 77.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.50 stddev:16.58 (19.9%) stddev-sans-first:17.22 19:13:51 INFO - PROCESS | 21523 | Values: 84.0 84.0 126.0 83.0 84.0 84.0 111.0 83.0 83.0 114.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:13:51 INFO - PROCESS | 21523 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:13:51 INFO - PROCESS | 21523 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 19:13:51 INFO - PROCESS | 21523 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 19:13:51 INFO - PROCESS | 21523 | Values: 65.0 65.0 65.0 64.0 64.0 65.0 65.0 66.0 66.0 66.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 19:13:51 INFO - PROCESS | 21523 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 68.0 66.0 67.0 67.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:4.79 (5.7%) stddev-sans-first:5.05 19:13:51 INFO - PROCESS | 21523 | Values: 84.0 83.0 83.0 83.0 83.0 83.0 89.0 84.0 98.0 84.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:141.00 stddev:13.57 (9.6%) stddev-sans-first:14.25 19:13:51 INFO - PROCESS | 21523 | Values: 140.0 143.0 141.0 138.0 141.0 152.0 138.0 137.0 182.0 141.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:2.94 (1.7%) stddev-sans-first:1.58 19:13:51 INFO - PROCESS | 21523 | Values: 182.0 173.0 175.0 176.0 175.0 174.0 173.0 172.0 172.0 176.0 19:13:51 INFO - PROCESS | 21523 | 19:13:51 INFO - PROCESS | 21523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 19:13:51 INFO - PROCESS | 21523 | Values: 68.0 70.0 70.0 69.0 69.0 70.0 69.0 69.0 69.0 68.0 19:13:51 INFO - PROCESS | 21523 | -------- Summary: end -------- 19:13:51 INFO - PROCESS | 21523 | 19:13:52 INFO - TEST-INFO | 21523: exit 0 19:13:52 INFO - TEST-OK | kraken | took 64890ms 19:13:52 INFO - SUITE-END | took 1186s 19:13:52 INFO - Completed test suite (00:19:47) 19:13:52 INFO - javascript benchmark 19:13:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.48650269946, 2588.2105957682925, 2601.336659151916, 2622.61972014058, 2638.788896888249, 4540.0, 4623.653226008055, 4671.322658214561, 4680.882977925549, 4689.906201875965, 4639.721616703, 4666.696664716791, 4670.836520721776, 4685.2035154023815, 4775.188218002939, 4268.7225330353585, 4328.134373125372, 4344.60898519134, 4381.868543943687, 4383.298672212447, 4317.071829556645, 4337.067530480946, 4346.8043938022865, 4352.97823510882, 4372.256716358211, 4370.278903980855, 4375.474943006843, 4420.823167073313, 4429.734215947037, 4456.086502267044, 4181.0592616661315, 4237.0890258594245, 4248.065425606362, 4301.698881078294, 4334.111507141029, 4201.76890271035, 4229.661627069827, 4255.361695745632, 4262.7655478948645, 4313.331433627793, 4614.215583350805, 4625.1443482955765, 4632.119897219518, 4637.234856248715, 4674.368960190365, 4822.7829747661435, 4947.826826061107, 4954.479779623124, 4960.454350021495, 4961.5286547777905, 4896.1186986342445, 4932.778024988848, 5003.624728145403, 5007.098722229997, 5088.313077734496, 4643.210654188796, 4651.116287905287, 4664.930026049612, 4669.41632295963, 4726.243800991825, 5144.845654630367, 5152.690838549699, 5153.871153221199, 5217.921731174036, 5220.738963051832, 4751.762411879461, 4796.544328288807, 4853.0, 4893.363862697826, 4903.607711383081, 5032.144535428986, 5032.597392208614, 5032.924506132338, 5034.84895453137, 5082.390113186441, 5004.874878128003, 5006.949930500721, 5007.974960125249, 5008.073506401327, 5055.418626857885, 4789.616830653539, 4844.903101937942, 4853.587445067138, 4877.512248775094, 5044.4198917125, 4238.427812245369, 4255.744655320629, 4255.87232383029, 4257.467816522934, 4264.57354264571, 3647.744657873923, 3661.5972243053243, 3688.170161713647, 3719.1445967427644, 3735.028892487973, 4335.523092459827, 4338.566143385699, 4374.278244089754, 4390.538993405647, 4392.780360981938, 5020.497950205024, 5025.597952163818, 5029.622778291643, 5034.270030845507, 5084.898302033938, 4147.585241475828, 4257.10600773841, 4263.786810659517, 4329.891752706208, 4334.783260836945, 4502.302143167814, 4526.479454862733, 4535.138323718483, 4579.335996280587, 4587.288970209623, 4684.110019096361, 4723.480417154179, 4725.078609671219, 4726.71639701619, 4764.547368000034, 4856.73287969151, 4864.1001414736975, 4991.700497970133, 4993.425756038102, 5031.295618613324, 4679.836205732783, 4706.458757242824, 4741.881452963704, 4776.808927642995, 4805.0, 4954.083494553519, 4958.033183529177, 4960.7767650456535, 4969.3291405659775, 5023.497650234947, 4811.855644330676, 5025.447200807835, 5027.446980832033, 5035.395752509722, 5085.110105731556, 4734.124187025412, 4753.809847606195, 4789.425268967746, 4805.879853003703, 4886.120498310338, 4829.879253018703, 4830.686005409637, 4839.516048395273, 4841.467438581823, 4898.093852637274, 4764.094821983812, 4768.284757286435, 4774.140654682191, 4777.904441911072, 4825.203841366135, 4730.881727956828, 4787.976060119677, 4834.63740219492, 4888.877778055577, 4909.77905994224, 4775.498572649822, 4779.617630589614, 4782.2826576012485, 4832.637552183671, 4837.903241935212], "value": 4585.444080318733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.7744208711298, 542.7666103575464, 547.1519145324746, 555.1395337227297, 566.5948846574703, 27575.0, 28297.15108546744, 38011.049723756885, 38832.80583597085, 38977.0, 39156.80421597888, 39658.80170599143, 39899.0, 39909.40135897964, 39969.400458993136, 7659.080910290759, 7792.0, 7797.0643522777345, 7802.60986950653, 7807.570583617899, 7293.452991025668, 7462.440316976222, 7493.550386976799, 9722.465264410455, 9988.101070903616, 10146.0, 10209.744756381077, 10210.64262750804, 10210.744731381701, 10221.591136354537, 9593.088656577649, 9643.566039528203, 9644.614215431375, 9654.22766178704, 9654.662086826998, 9713.271504637181, 9761.804763904682, 9768.51157442125, 9772.169365603932, 9777.0, 37764.62235377639, 37892.81053594742, 37958.810205948794, 37997.43003854944, 38033.23933521314, 2890.6675732290846, 2907.0, 2910.3160757222035, 3053.3587946531256, 3241.8379081045855, 27698.446031079468, 28234.576481352797, 28559.714402855912, 28608.0, 29390.41219175626, 3405.897823065312, 3482.8084455354947, 3492.3364560733635, 3497.0732755819727, 3526.682598566141, 242924.0, 243157.0, 243312.0, 243572.0, 244065.0, 52458.327917046205, 52954.735226324396, 53006.0, 53016.0, 53027.20459193115, 32265.193370165933, 33356.3328733424, 33384.66615333864, 34967.0, 35004.0, 14392.856071439151, 14571.271436428136, 14581.343839527246, 14585.562433127023, 14589.489367872073, 9631.470269135265, 9631.614735410505, 9635.518224088768, 9654.855177172349, 9679.370840895319, 14960.177190254422, 17070.658586828442, 17669.7349539757, 17922.820771792376, 18400.26398944027, 6565.901511477332, 6652.567583107082, 6897.655117244118, 6956.756513522104, 7017.3684368407085, 726.90963554668, 779.859625267446, 814.9975530098012, 859.9699010534601, 920.3603495570514, 26205.868970655025, 27259.863700681766, 27269.45461090767, 27636.0, 27750.722492775218, 889.7375274294099, 891.5453118909273, 894.7360528644066, 922.1055576091181, 969.2488321550713, 14101.435942562182, 14899.70200595982, 14918.627034324229, 15043.924780376028, 15122.54632361031, 348686.0, 353967.0, 354747.7878318273, 355712.0, 357750.0, 48525.993211120476, 49012.0, 49012.26481602779, 49057.0, 49452.50547494479, 1052.7947050325267, 1068.4764465412047, 1126.4367816091954, 1148.3970915269551, 1163.6392718257368, 25658.358541036625, 28599.714002859706, 29244.41511169722, 29281.0, 29747.85126074356, 41447.171056579304, 41994.58005419907, 42014.57985420229, 42036.0, 42052.57947420487, 284017.0, 285026.0, 285249.0, 285347.0, 285519.0, 21573.568528629654, 22183.0, 22325.888370558045, 22342.77657223407, 25555.87222063878, 40675.93240676027, 41202.175956481304, 41687.0, 41858.37212441755, 42423.0, 35260.64739352574, 35278.29443411169, 35333.646663533036, 35501.28997420089, 35758.46362304516, 35721.1069723259, 35962.4605630921, 36277.09307267339, 36324.63675363318, 36371.45442818307, 35386.0, 35527.64472355243, 35876.461853072746, 36213.456798148574, 36400.27199456049, 30351.696483034888, 32681.34637307288, 32845.0, 32909.341813163126, 33175.83412082924, 25129.24612261635, 25569.74430255748, 25612.231633051037, 25617.871910640326, 25751.871240643675], "value": 17151.255682141527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.0, 343.72306879941016, 350.9964900350997, 352.77775001748904, 376.625257868421, 12199.695007624814, 15780.44939888526, 16141.515754527369, 16639.0, 17730.0, 16041.518754437357, 16677.1661416929, 16958.915205423957, 17143.57141071474, 17210.741838872425, 3736.9065773355746, 4862.854114376565, 5025.623078269126, 5070.543651071403, 5101.897962040757, 3638.2541578976247, 3818.9045273868237, 4884.19410797218, 5534.197541356501, 5826.650400975955, 5884.235049443566, 5898.085796701518, 5902.675352855591, 5903.970480147594, 5909.11363295507, 5610.859728506779, 5779.393163717791, 5821.941780582203, 5841.357450680422, 5886.764529418818, 4961.975190124026, 5141.0, 5144.408393034774, 5146.073706732786, 5153.304303918961, 20428.0, 20465.4883627909, 20528.0, 20826.687599686018, 20826.895865520575, 1765.62921786425, 1886.6132442849182, 1920.807919208082, 1956.2859556261863, 2026.7973202679761, 12556.497740090386, 13225.86774132256, 13562.864371356358, 13801.378937947817, 13820.516281930084, 1607.3570571771268, 1682.806477255119, 1834.7431359609532, 1836.9816301836945, 1856.8885866848032, 62170.68914655443, 65260.3473965259, 65731.67134164298, 66268.33731662718, 66367.0, 8464.492130472192, 8820.603072861737, 8993.14565116313, 9019.368644194974, 9146.679866204784, 12077.637670869888, 12087.274763514217, 12104.87895121055, 12106.394680265952, 12120.636380908587, 6802.183737951477, 6897.655117244118, 6951.65241737911, 7066.611336376446, 7104.68028938699, 6776.356246156607, 6787.728490860311, 6840.828979275558, 6992.895106573405, 7072.575645461186, 3823.6941044716355, 3847.0, 3896.357101078347, 3896.4155376693157, 3940.802959851996, 1620.376155180264, 1667.2164082881027, 1677.4296739108518, 1737.37454516374, 1825.762650855407, 795.9243871832167, 842.2588122452325, 884.3146561414954, 922.2345453273766, 922.847730124522, 16305.0, 16698.6660266794, 17168.742468862976, 17632.118394080244, 17745.822541774418, 814.8696208606594, 819.3772732723173, 819.8360327934437, 824.1552408780927, 835.5028757889046, 9307.767305817273, 9889.505524723734, 9893.109620134079, 9903.702888913343, 10029.64896228643, 347490.0, 357062.0, 357262.0, 358666.0, 359162.0, 73310.63685128813, 73402.0, 73548.89676654854, 73652.26347736454, 75302.0, 888.2893685052062, 912.9178373946377, 932.3147486597345, 934.5560858592114, 943.4669411782321, 14605.634859128606, 14832.035917665316, 14948.177850218342, 15481.690366192388, 15617.0, 35442.64557354394, 35632.0, 36218.275634486636, 36331.0, 36448.08879778027, 48567.757161213965, 48776.5122348772, 48793.512064878894, 48905.5109448901, 48959.0, 7423.628818558943, 7567.470277080552, 7624.466287360054, 7689.385229101951, 7861.410394220571, 10638.361698298128, 10804.297720648132, 10805.297655652672, 11833.526658933546, 12243.020558355132, 9483.193928516153, 10040.246981476565, 10280.434576098387, 10447.63433279862, 10562.630307939186, 9561.043895610383, 9805.558749856416, 9906.157976572073, 10062.547185376528, 10078.899211008089, 9607.711768646952, 10279.434631095362, 10448.843267351147, 10680.359178449318, 11256.324620522795, 7597.164311925573, 7600.733974311093, 7616.885746713914, 7756.457048006585, 7955.721549745731, 10278.074973252444, 10279.897201028192, 10522.1056210223, 10629.787404252027, 11016.889831101907], "value": 8063.96342496896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.0121510689644, 1361.6391656211104, 1419.16978567538, 1628.1045425016252, 1667.458076125259, 7059.752908648192, 7649.502782319159, 7667.539947603148, 7670.0, 7674.155842857282, 6400.935990640092, 6643.468522518187, 7014.684339204735, 7277.454190935675, 7281.854362912739, 2082.28161284357, 2112.915483380663, 2115.629764791163, 2116.9259075932346, 2118.0, 2045.1103769860083, 2050.897455127245, 2076.636588596997, 2084.5414008918015, 2096.727425434691, 1722.4229882989214, 1802.5223315821318, 2005.2179649936536, 2078.449210959097, 2078.6570215914358, 2078.1583458699174, 2102.516421223112, 2107.336189100436, 2108.325335892515, 2108.8523803333774, 2036.378904434147, 2078.542720601465, 2080.3966849613594, 2083.468715477559, 2084.6560317547587, 7239.276072392771, 7271.418286537064, 7291.744788932362, 7292.635368231568, 7295.927040729578, 4301.075268817188, 4500.797464114123, 4510.797014134372, 4511.323301504801, 4513.458384993789, 2844.317363832686, 2923.6199294091844, 2976.1815500737252, 2977.523596224615, 2984.492636251842, 885.7785553611598, 942.236788201559, 951.8286708392486, 952.9666461673808, 963.6386355116831, 10187.286889917708, 10210.693679189637, 10263.127634151106, 10288.331258468175, 10292.485375731183, 3667.7799332040163, 3859.826307816155, 3981.0843505993203, 3986.202759448122, 4014.8193331300163, 8626.266767324847, 8695.391322607484, 8702.82594348122, 8704.129587041372, 8711.259542938795, 4481.887952801206, 4489.5959363656775, 4496.437945256843, 4499.257622492252, 4510.368548403226, 4046.4537287466405, 4107.712460127762, 4108.5275193352545, 4114.177164567099, 4115.382692596135, 3358.311546133086, 3460.169559305799, 3501.3347463981763, 3517.577890653087, 3628.4738712886483, 1078.1051727066515, 1106.0930037369442, 1111.0611533254548, 1125.2460851229696, 1127.9943600281947, 558.0162522233418, 684.4045680258108, 807.2734538914906, 845.5560830564003, 865.8831057807241, 5001.199808030698, 5113.258577506241, 5220.791168353299, 5256.448072952361, 5315.840524784263, 803.2569872867574, 838.8322335532796, 861.9482831030158, 862.3833958719421, 868.4398562927003, 3408.897733068012, 3571.267890082579, 3572.3034008368118, 3588.820558972041, 3681.9447708284397, 8596.484210947363, 8943.3739638226, 8951.955240223888, 9042.954785226031, 9106.95446522763, 8930.821383572293, 8976.461412315282, 9005.0, 9012.143846334588, 9012.504312262889, 6851.862962740817, 6915.585064896122, 6990.755323563651, 7005.0, 7010.404115650125, 4912.140375434214, 4976.850694479172, 5027.698338099725, 5061.215511595708, 5236.423993360803, 8247.21651443112, 8292.37807164477, 8376.539290338846, 8393.160683931557, 8444.155584441507, 8395.83208335842, 8487.0, 8493.915060849313, 8524.232819046316, 8526.957365213382, 6318.336574659595, 6335.4931605472375, 6545.705443254969, 6609.933900660932, 6747.628880411625, 7367.77896663101, 7420.962895185489, 7428.554286742813, 7436.293552112541, 7437.51656142349, 6549.836254093686, 6602.570832895846, 6645.435138013323, 6666.966665166643, 6770.424513916372, 6435.549511534147, 6450.129232553545, 6466.32103629131, 6502.252240992347, 6591.736330546724, 6151.938480615316, 6153.077038444269, 6208.441240288215, 6214.4407003369915, 6217.533684973736, 4399.076193999168, 4428.844990425319, 4523.932141017822, 4550.522195169459, 4593.793279302507, 4388.429504164438, 4408.250597398386, 4535.455745310584, 4556.840510582114, 4714.15145273854], "value": 3979.6842639273755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.53687184581366, 282.8034516011373, 287.3950334545782, 293.5391435446349, 297.40370557033145, 4712.269598212274, 4768.761561921908, 4783.30642056902, 4783.402074740658, 4798.328234047236, 4687.320338550908, 4709.128811169936, 4728.716277023381, 4735.952640473594, 4743.217369134098, 3467.497212904134, 3595.2989167112423, 3659.3047321009058, 3707.90730231745, 3745.681617062553, 3726.2920045191327, 3726.3851464508325, 3730.7388482806214, 3750.8687195948146, 3751.1747415568666, 3694.6305369463107, 3705.8702945396917, 3706.666400023997, 3708.7033037357082, 3710.3506886294927, 3514.472829075646, 3568.7680300780626, 3648.2703459308245, 3701.611330810253, 3703.4445532876257, 3254.576905002358, 3258.1691668624585, 3260.3153337798853, 3262.951055734166, 3266.5263536787033, 4580.977095114503, 4585.449746030465, 4596.701214421086, 4599.724016559017, 4638.721676699409, 3920.2551515212017, 4150.418941348214, 4224.894377640553, 4226.949929284295, 4239.978800106011, 4942.431620363633, 4946.516045186466, 4949.529794669501, 4954.950450495485, 4955.430125535573, 3447.6035255945635, 3451.4650229214512, 3454.913627159316, 3460.913477163091, 3475.9131021724406, 5007.7575842234055, 5199.662021968597, 5205.115130427798, 5220.321358223407, 5238.0, 3527.400341941876, 3544.1848374873925, 3553.466979953028, 3562.287542491512, 3588.8385022674042, 3604.5854726706766, 3608.7654302470255, 3620.2035552178477, 3622.3298689742483, 3625.1118475973553, 4174.874753757392, 4178.101708132705, 4181.644560212416, 4188.518320393194, 4194.496660400771, 4657.464391594942, 4910.705357678551, 5012.573931215815, 5021.0, 5029.17018691919, 1239.7706424311532, 1253.260576260011, 1256.8617452080264, 1258.1130303136267, 1260.710036691566, 772.4129661457333, 797.9148358232799, 811.6996711216769, 813.2558708781517, 813.9784570364155, 4024.2957482441043, 4267.5732426757695, 4342.0, 4396.9120617588105, 4463.8214471421425, 4994.950050499521, 5109.0, 5122.0, 5126.333576635088, 5147.301390541113, 4438.889027774331, 4442.422485076984, 4444.533324000933, 4457.487388950312, 4461.0, 2637.643918071074, 2684.6644169478814, 2708.404151086758, 2729.495043416974, 2729.5905614158037, 4869.099216644861, 4870.439899411542, 4873.221274234878, 4876.244182151772, 4879.194932836042, 5247.2129180623215, 5265.7103859287345, 5291.232771248147, 5294.947050529446, 5295.4846447936925, 4731.668783185213, 4805.1590971579835, 4818.614510839125, 4853.51464853526, 4878.634102442402, 5084.339035925306, 5129.87175320605, 5147.150720131136, 5155.252488389237, 5158.535731784007, 4986.750662466935, 5054.368203974504, 5055.0538042854505, 5059.266406370982, 5093.643444958817, 4593.816247350069, 4756.191447453872, 4812.879678007937, 4865.051314993542, 4879.316895634685, 3519.8768043118366, 3543.36219480496, 3543.6002778902703, 3550.538430004083, 3579.6957258632265, 5104.821331253388, 5126.743947732829, 5129.2819005340025, 5131.461196574455, 5138.640295179302, 4757.286407038971, 4894.461609222912, 4898.828541001048, 4933.506649335038, 4982.526659967298, 4933.876653083558, 4935.950640493693, 4938.901221975612, 4945.23348880924, 4948.169177404384, 4890.559849613552, 4896.4124305083615, 4900.0, 4910.9263361050325, 4919.803207871645, 4722.693024953367, 4739.810407583658, 4932.0, 4939.456659767351, 4986.083141362344, 4683.742394168354, 4748.216544270295, 4827.831025914076, 4827.95172048275, 4837.323634038086], "value": 3722.5011374068067, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.7778437484537, 603.5714642603748, 660.8281846719857, 716.9962053125627, 746.925307469253, 12780.0, 13507.25710085945, 14070.4371825127, 14083.507077252298, 14317.069390489636, 12663.746725065494, 12873.163244389109, 12896.74206515869, 12899.484020639187, 12901.677458063554, 754.6151462754008, 774.0711146624045, 775.0118598786536, 775.0505630602495, 775.7284950267418, 602.1900543768625, 624.1947887225474, 733.9376153026999, 760.5664771080486, 768.0054329643126, 813.4834380168577, 814.861473549498, 815.604431850552, 815.7552734179752, 815.8776183572481, 807.8828569857396, 809.4091313341264, 809.4172196018857, 809.5345176523523, 809.6194788449449, 465.6530884491042, 476.43304467683345, 566.4590316247974, 584.1004852527103, 596.588354035714, 12548.247105173628, 12573.308468034254, 12578.182418142791, 12578.74842503154, 12583.559575414816, 11713.837263938774, 11715.02221247195, 12055.93972030143, 12417.813732794015, 12725.936370318183, 11015.118790496741, 11107.555697772079, 11189.608363707232, 11386.601468948547, 11415.828762568568, 4010.258102251093, 4031.9395209071886, 4064.166845796605, 4111.7944102794745, 4117.485314335708, 60982.69508652473, 61817.07274390888, 62569.37430625681, 62592.68703656452, 62843.6857815708, 9875.358101723365, 9877.0, 9890.456024918554, 9973.351732137387, 10030.398176109456, 16647.16764161787, 17351.82648173502, 17391.565210869576, 18332.63334733298, 18424.631507369777, 6713.69788359525, 6749.0888730020815, 6970.198427180838, 7001.089858318386, 7010.964945175241, 3659.268146370683, 3753.11801726594, 3764.7176461765475, 3770.4155855842387, 3790.507234059555, 2718.8912443502436, 2814.9718502815117, 2831.5327970884573, 2837.092130518214, 2842.7725781937397, 481.26126395982, 483.4126536258463, 488.19447910946514, 489.45670305960357, 493.1247036510223, 579.5305802300151, 581.4272941152961, 607.3289015637745, 625.871696302257, 629.568745409396, 8545.273651739548, 8781.20969112783, 8843.248323892412, 8903.688370906988, 9026.0, 470.543572734447, 558.1293182635102, 575.3929604267538, 584.1850618387326, 591.204829504316, 3860.8069596520063, 4203.864956461738, 4283.571642835692, 4378.124375124988, 4393.319035549495, 75789.62105189438, 101400.0, 102688.48655756674, 104313.0, 105125.0, 86670.56664716636, 87815.56092219499, 88396.0, 89615.0, 89980.5500972491, 71977.28022719706, 74115.62942185254, 74640.0, 74692.25307746962, 78210.6089469549, 8079.272865442138, 8347.332213423033, 8410.744793715923, 8510.957445212734, 8551.74344769658, 43908.0, 44459.55540444684, 45123.774381127885, 45382.546174537834, 45405.0, 61861.69069154625, 65249.347506524326, 65931.67034164799, 65983.6700816512, 67389.66305168443, 9691.418514889128, 10331.431771252654, 11136.498857551267, 11185.944070279596, 11339.829902551302, 12946.226052971411, 13045.412956416794, 13440.0, 13529.59411217665, 14147.787783183467, 12151.696207594881, 12205.572804951784, 12254.080943929419, 12346.81479777786, 12627.684307892376, 12012.519499219934, 12402.0, 12598.433070511666, 12656.101584762358, 12668.176568523017, 12019.819702704292, 12413.379331033593, 12441.564545241235, 12568.120231583702, 13168.144070635379, 9843.409395436296, 10145.28982971185, 10184.134348580454, 10565.154787617126, 10663.093637040938, 9757.0, 9995.350302230332, 10081.294309398272, 10082.29423940317, 10169.593216271267], "value": 6613.678113362605, "unit": "score"}], "name": "dromaeo_css", "value": 6293.621403720722, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 116.0, 117.0, 114.0, 116.0, 116.0, 115.0, 117.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 128.0, 168.0, 129.0, 127.0, 127.0, 131.0, 166.0, 131.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 161.0, 161.0, 159.0, 162.0, 160.0, 160.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 101.0, 77.0, 76.0, 76.0, 75.0, 107.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 83.0, 84.0, 84.0, 111.0, 83.0, 83.0, 114.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 83.0, 83.0, 89.0, 84.0, 98.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 143.0, 141.0, 138.0, 141.0, 152.0, 138.0, 137.0, 182.0, 141.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 173.0, 175.0, 176.0, 175.0, 174.0, 173.0, 172.0, 172.0, 176.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1556.2, "alertThreshold": 2.0}]} 19:13:52 INFO - Return code: 0 19:13:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:13:52 INFO - # TBPL SUCCESS # 19:13:52 INFO - Running post-action listener: _resource_record_post_action 19:13:52 INFO - [mozharness: 2016-10-05 02:13:52.808481Z] Finished run-tests step (success) 19:13:52 INFO - Running post-run listener: _resource_record_post_run 19:13:52 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 402079744; Read time: 240; Write time: 267584 19:13:52 INFO - TinderboxPrint: CPU usage
13.0% 19:13:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 240 19:13:52 INFO - TinderboxPrint: I/O write bytes / time
402,079,744 / 267,584 19:13:52 INFO - TinderboxPrint: CPU idle
8,346.9 (86.9%) 19:13:52 INFO - TinderboxPrint: CPU user
1,203.6 (12.5%) 19:13:52 INFO - TinderboxPrint: Swap in / out
0 / 0 19:13:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110538752; Read time: 104; Write time: 59824 19:13:52 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291540992; Read time: 136; Write time: 207760 19:13:53 INFO - Running post-run listener: _upload_blobber_files 19:13:53 INFO - Blob upload gear active. 19:13:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:13:53 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 19:13:53 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:13:53 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:13:53 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:54 INFO - (blobuploader) - INFO - Done attempting. 19:13:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:13:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:55 INFO - (blobuploader) - INFO - Done attempting. 19:13:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:13:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:01 INFO - (blobuploader) - INFO - Done attempting. 19:14:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:14:01 INFO - Return code: 0 19:14:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:14:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:14:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d238a7421fdbd84ea150bfd59ddfd8401ccf72ee5aea5445ff3aa05da04bd308bc702d16701b13a38e9bec85ecefeccce78f6827417827a0b1d16190b3409c55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/882b6e0bf3e86081a4fcd181c23b12ad489ead07200e2cea36b8c9bc06b7944e22cf12e04a59a9ce7a930894bad5aa7f241be79b74ffc3c01f00e90a19624738", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a84f38746e1a3c478eb9ea7584b3acfa2650db47be970c8908c41568ee855a260981feb74bf8ea272a19ba32da9750c83ed256e6d5d8e8e1548c59988cd0a88"} 19:14:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:14:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:14:01 INFO - Contents: 19:14:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d238a7421fdbd84ea150bfd59ddfd8401ccf72ee5aea5445ff3aa05da04bd308bc702d16701b13a38e9bec85ecefeccce78f6827417827a0b1d16190b3409c55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/882b6e0bf3e86081a4fcd181c23b12ad489ead07200e2cea36b8c9bc06b7944e22cf12e04a59a9ce7a930894bad5aa7f241be79b74ffc3c01f00e90a19624738", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a84f38746e1a3c478eb9ea7584b3acfa2650db47be970c8908c41568ee855a260981feb74bf8ea272a19ba32da9750c83ed256e6d5d8e8e1548c59988cd0a88"} 19:14:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:14:01 INFO - Copying logs to upload dir... 19:14:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:14:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.617030 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 19:14:01.170625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 19:14:01.174088) ========= 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=db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d238a7421fdbd84ea150bfd59ddfd8401ccf72ee5aea5445ff3aa05da04bd308bc702d16701b13a38e9bec85ecefeccce78f6827417827a0b1d16190b3409c55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/882b6e0bf3e86081a4fcd181c23b12ad489ead07200e2cea36b8c9bc06b7944e22cf12e04a59a9ce7a930894bad5aa7f241be79b74ffc3c01f00e90a19624738", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a84f38746e1a3c478eb9ea7584b3acfa2650db47be970c8908c41568ee855a260981feb74bf8ea272a19ba32da9750c83ed256e6d5d8e8e1548c59988cd0a88"} build_url:https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/Nrb_01ZtTeWtKSQSn212_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d238a7421fdbd84ea150bfd59ddfd8401ccf72ee5aea5445ff3aa05da04bd308bc702d16701b13a38e9bec85ecefeccce78f6827417827a0b1d16190b3409c55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/882b6e0bf3e86081a4fcd181c23b12ad489ead07200e2cea36b8c9bc06b7944e22cf12e04a59a9ce7a930894bad5aa7f241be79b74ffc3c01f00e90a19624738", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a84f38746e1a3c478eb9ea7584b3acfa2650db47be970c8908c41568ee855a260981feb74bf8ea272a19ba32da9750c83ed256e6d5d8e8e1548c59988cd0a88"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 19:14:01.199262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 19:14:01.199578) ========= 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=db7e7c15f3ca076d53731445000001ba-1475629722.851071-802240007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 19:14:01.283528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 19:14:01.283848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 19:14:01.284141) ========= ========= Total master_lag: 0.35 =========