builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1475585578.81 results: success (0) buildid: 20161004030204 builduid: 81824e86463249a5a814cb2a6b4fa514 revision: 42c95d88aaaa7c2eca1d278399421d437441ac4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.806810) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.807323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.807621) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.824778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.825210) ========= 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=df17445c3590ff7897617a0e00000225-1475584707.264093-877291153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 05:52:58-- 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% 42.9M=0s 2016-10-04 05:52:59 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.934883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.935199) ========= 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=df17445c3590ff7897617a0e00000225-1475584707.264093-877291153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023486 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.991889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:58.992212) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42c95d88aaaa7c2eca1d278399421d437441ac4d --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 42c95d88aaaa7c2eca1d278399421d437441ac4d --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=df17445c3590ff7897617a0e00000225-1475584707.264093-877291153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 05:52:59,140 truncating revision to first 12 chars 2016-10-04 05:52:59,140 Setting DEBUG logging. 2016-10-04 05:52:59,140 attempt 1/10 2016-10-04 05:52:59,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42c95d88aaaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 05:52:59,444 unpacking tar archive at: mozilla-central-42c95d88aaaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:59.621205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:59.621508) ========= script_repo_revision: 42c95d88aaaa7c2eca1d278399421d437441ac4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:59.621923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:59.622223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 05:52:59.632752) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-04 05:52:59.633048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=df17445c3590ff7897617a0e00000225-1475584707.264093-877291153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:59 INFO - MultiFileLogger online at 20161004 05:52:59 in /builds/slave/test 05:52:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:59 INFO - {'append_to_log': False, 05:52:59 INFO - 'base_work_dir': '/builds/slave/test', 05:52:59 INFO - 'blob_upload_branch': 'Firefox', 05:52:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:59 INFO - 'branch': 'Firefox', 05:52:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:59 INFO - 'config_files': ('talos/linux_config.py',), 05:52:59 INFO - 'default_actions': ('clobber', 05:52:59 INFO - 'read-buildbot-config', 05:52:59 INFO - 'download-and-extract', 05:52:59 INFO - 'populate-webroot', 05:52:59 INFO - 'create-virtualenv', 05:52:59 INFO - 'install', 05:52:59 INFO - 'run-tests'), 05:52:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:59 INFO - 'download_minidump_stackwalk': True, 05:52:59 INFO - 'download_symbols': 'ondemand', 05:52:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:59 INFO - 'installer_path': 'installer.exe', 05:52:59 INFO - 'log_level': 'info', 05:52:59 INFO - 'log_name': 'talos', 05:52:59 INFO - 'log_to_console': True, 05:52:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:59 INFO - 'opt_config_files': (), 05:52:59 INFO - 'pip_index': False, 05:52:59 INFO - 'sps_profile': False, 05:52:59 INFO - 'sps_profile_interval': 0, 05:52:59 INFO - 'suite': 'dromaeojs', 05:52:59 INFO - 'system_bits': '32', 05:52:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:59 INFO - 'title': 'talos-linux64-ix-021', 05:52:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:59 INFO - 'use_talos_json': True, 05:52:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:59 INFO - 'work_dir': 'build'} 05:52:59 INFO - [mozharness: 2016-10-04 12:52:59.876395Z] Running clobber step. 05:52:59 INFO - Running pre-action listener: _resource_record_pre_action 05:52:59 INFO - Running main action method: clobber 05:52:59 INFO - rmtree: /builds/slave/test/build 05:52:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:53:00 INFO - Running post-action listener: _resource_record_post_action 05:53:00 INFO - [mozharness: 2016-10-04 12:53:00.842127Z] Finished clobber step (success) 05:53:00 INFO - [mozharness: 2016-10-04 12:53:00.842226Z] Running read-buildbot-config step. 05:53:00 INFO - Running pre-action listener: _resource_record_pre_action 05:53:00 INFO - Running main action method: read_buildbot_config 05:53:00 INFO - Using buildbot properties: 05:53:00 INFO - { 05:53:00 INFO - "project": "", 05:53:00 INFO - "product": "firefox", 05:53:00 INFO - "script_repo_revision": "production", 05:53:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:53:00 INFO - "repository": "", 05:53:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:53:00 INFO - "buildid": "20161004030204", 05:53:00 INFO - "stage_platform": "linux64-pgo", 05:53:00 INFO - "basedir": "/builds/slave/test", 05:53:00 INFO - "nightly_build": "True", 05:53:00 INFO - "buildnumber": 15, 05:53:00 INFO - "slavename": "talos-linux64-ix-021", 05:53:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:53:00 INFO - "platform": "ubuntu64_hw", 05:53:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:53:00 INFO - "branch": "mozilla-central", 05:53:00 INFO - "repo_path": "mozilla-central", 05:53:00 INFO - "revision": "42c95d88aaaa7c2eca1d278399421d437441ac4d", 05:53:00 INFO - "pgo_build": "True", 05:53:00 INFO - "builduid": "81824e86463249a5a814cb2a6b4fa514", 05:53:00 INFO - "slavebuilddir": "test" 05:53:00 INFO - } 05:53:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:53:00 INFO - Running post-action listener: _resource_record_post_action 05:53:00 INFO - [mozharness: 2016-10-04 12:53:00.844729Z] Finished read-buildbot-config step (success) 05:53:00 INFO - [mozharness: 2016-10-04 12:53:00.844817Z] Running download-and-extract step. 05:53:00 INFO - Running pre-action listener: _resource_record_pre_action 05:53:00 INFO - Running main action method: download_and_extract 05:53:00 INFO - mkdir: /builds/slave/test/build/tests 05:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:00 INFO - trying https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:53:00 INFO - Downloading https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/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 05:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/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 05:53:01 INFO - Downloaded 1361 bytes. 05:53:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:53:01 INFO - Using the following test package requirements: 05:53:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:53:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:53:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'jsshell-linux-x86_64.zip'], 05:53:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:53:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:53:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:53:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:53:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:53:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:53:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:53:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:01 INFO - Fetch https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:53:02 INFO - Http code: 200 05:53:02 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 05:53:02 INFO - x-amz-cf-id: uGNmsExK1bvkYaSMhP6OBDa7kS9sP6lqCJRlWIXYSUOPHXUx70wAPA== 05:53:02 INFO - x-amz-version-id: fdM.7e3rj__7bpqLzSusqwj8u32uP7Cv 05:53:02 INFO - Expected file size: 21992592 05:53:02 INFO - Obtained file size: 21992592 05:53:06 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 05:53:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:53:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:06 INFO - Fetch https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:53:07 INFO - Http code: 200 05:53:07 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 05:53:07 INFO - x-amz-cf-id: niXoV0_FRThQWYYWcb1SAkfH1nRbGPvWqrClFMfNTAjILN2RlXCU2g== 05:53:07 INFO - x-amz-version-id: fdM.7e3rj__7bpqLzSusqwj8u32uP7Cv 05:53:07 INFO - Expected file size: 21992592 05:53:07 INFO - Obtained file size: 21992592 05:53:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:53:11 INFO - Fetch https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:53:12 INFO - Http code: 200 05:53:12 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 05:53:12 INFO - x-amz-cf-id: n0UNPn6BMsZ1aOsR1aCsuztTUPoG-DmSD8mA9CULKTeMhwh568Pacg== 05:53:12 INFO - x-amz-version-id: 0JZAXDFRvlbPf9JKuNYuu_0pEuAUPhyr 05:53:13 INFO - Expected file size: 14409006 05:53:13 INFO - Obtained file size: 14409006 05: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')]} 05:53:13 INFO - trying https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:53:13 INFO - Downloading https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/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 05:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/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 05:53:15 INFO - Downloaded 59694217 bytes. 05:53:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:53:15 INFO - mkdir: /builds/slave/test/properties 05:53:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:15 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:15 INFO - Contents: 05:53:15 INFO - build_url:https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:53:16 INFO - Running post-action listener: _resource_record_post_action 05:53:16 INFO - Running post-action listener: set_extra_try_arguments 05:53:16 INFO - [mozharness: 2016-10-04 12:53:16.286700Z] Finished download-and-extract step (success) 05:53:16 INFO - [mozharness: 2016-10-04 12:53:16.286927Z] Running populate-webroot step. 05:53:16 INFO - Running pre-action listener: _resource_record_pre_action 05:53:16 INFO - Running main action method: populate_webroot 05:53:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:16 INFO - '--tppagecycles', 05:53:16 INFO - '7'], 05:53:16 INFO - 'tests': ['tsvgm']}}, 05:53:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['damp', 'tps']}, 05:53:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'tests': ['damp', 'tps']}, 05:53:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['dromaeo_dom']}, 05:53:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['basic_compositor_video']}, 05:53:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:53:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore', 05:53:16 INFO - 'tabpaint']}, 05:53:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore', 05:53:16 INFO - 'tabpaint']}, 05:53:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore', 05:53:16 INFO - 'tabpaint']}, 05:53:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore', 05:53:16 INFO - 'tabpaint']}, 05:53:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore', 05:53:16 INFO - 'tabpaint']}, 05:53:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore', 05:53:16 INFO - 'tabpaint']}, 05:53:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['tsvgx', 05:53:16 INFO - 'tsvgr_opacity', 05:53:16 INFO - 'tart', 05:53:16 INFO - 'tscrollx', 05:53:16 INFO - 'cart']}, 05:53:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:16 INFO - 'tsvgr_opacity', 05:53:16 INFO - 'tart', 05:53:16 INFO - 'tscrollx', 05:53:16 INFO - 'cart']}, 05:53:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--disable-e10s'], 05:53:16 INFO - 'tests': ['tp5o']}, 05:53:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'tests': ['tp5o']}, 05:53:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--disable-e10s', 05:53:16 INFO - '--xperf_path', 05:53:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:16 INFO - 'tests': ['tp5n']}, 05:53:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--xperf_path', 05:53:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:16 INFO - 'tests': ['tp5n']}}, 05:53:16 INFO - 'talos.zip': {'path': '', 05:53:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:16 INFO - Running post-action listener: _resource_record_post_action 05:53:16 INFO - [mozharness: 2016-10-04 12:53:16.308242Z] Finished populate-webroot step (success) 05:53:16 INFO - [mozharness: 2016-10-04 12:53:16.308329Z] Running create-virtualenv step. 05:53:16 INFO - Running pre-action listener: _resource_record_pre_action 05:53:16 INFO - Running main action method: create_virtualenv 05:53:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:16 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 05:53:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:16 INFO - Using real prefix '/usr' 05:53:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:18 INFO - Installing pip.................done. 05:53:18 INFO - Return code: 0 05:53:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:53:19 INFO - Reading from file tmpfile_stdout 05:53:19 INFO - Output received: 05:53:19 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) 05:53:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:19 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')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:19 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 05:53:19 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 05:53:19 INFO - Using env: {'DISPLAY': ':0', 05:53:19 INFO - 'HOME': '/home/cltbld', 05:53:19 INFO - 'LANG': 'en_US.UTF-8', 05:53:19 INFO - 'LANGUAGE': 'en_US:en', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MAIL': '/var/mail/cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SHLVL': '1', 05:53:19 INFO - 'TERM': 'linux', 05:53:19 INFO - 'TMOUT': '86400', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - '_': '/tools/buildbot/bin/python'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 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 05:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:19 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')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:19 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 05:53:19 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 05:53:19 INFO - Using env: {'DISPLAY': ':0', 05:53:19 INFO - 'HOME': '/home/cltbld', 05:53:19 INFO - 'LANG': 'en_US.UTF-8', 05:53:19 INFO - 'LANGUAGE': 'en_US:en', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MAIL': '/var/mail/cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SHLVL': '1', 05:53:19 INFO - 'TERM': 'linux', 05:53:19 INFO - 'TMOUT': '86400', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - '_': '/tools/buildbot/bin/python'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 INFO - Downloading/unpacking psutil>=3.1.1 05:53:19 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 05:53:19 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 05:53:19 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 05:53:19 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 05:53:19 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 05:53:19 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 05:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:21 INFO - Installing collected packages: psutil 05:53:21 INFO - Running setup.py install for psutil 05:53:21 INFO - building 'psutil._psutil_linux' extension 05:53:21 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 05:53:21 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 05:53:21 INFO - building 'psutil._psutil_posix' extension 05:53:21 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 05:53:21 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 05:53:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:22 INFO - Successfully installed psutil 05:53:22 INFO - Cleaning up... 05:53:22 INFO - Return code: 0 05:53:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:53:22 INFO - Using env: {'DISPLAY': ':0', 05:53:22 INFO - 'HOME': '/home/cltbld', 05:53:22 INFO - 'LANG': 'en_US.UTF-8', 05:53:22 INFO - 'LANGUAGE': 'en_US:en', 05:53:22 INFO - 'LOGNAME': 'cltbld', 05:53:22 INFO - 'MAIL': '/var/mail/cltbld', 05:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:22 INFO - 'MOZ_NO_REMOTE': '1', 05:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:22 INFO - 'NO_EM_RESTART': '1', 05:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:22 INFO - 'PWD': '/builds/slave/test', 05:53:22 INFO - 'SHELL': '/bin/bash', 05:53:22 INFO - 'SHLVL': '1', 05:53:22 INFO - 'TERM': 'linux', 05:53:22 INFO - 'TMOUT': '86400', 05:53:22 INFO - 'USER': 'cltbld', 05:53:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:22 INFO - '_': '/tools/buildbot/bin/python'} 05:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:24 INFO - Installing collected packages: mozsystemmonitor 05:53:24 INFO - Running setup.py install for mozsystemmonitor 05:53:24 INFO - Successfully installed mozsystemmonitor 05:53:24 INFO - Cleaning up... 05:53:24 INFO - Return code: 0 05:53:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:24 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:24 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 05:53:24 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 05:53:24 INFO - Using env: {'DISPLAY': ':0', 05:53:24 INFO - 'HOME': '/home/cltbld', 05:53:24 INFO - 'LANG': 'en_US.UTF-8', 05:53:24 INFO - 'LANGUAGE': 'en_US:en', 05:53:24 INFO - 'LOGNAME': 'cltbld', 05:53:24 INFO - 'MAIL': '/var/mail/cltbld', 05:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:24 INFO - 'MOZ_NO_REMOTE': '1', 05:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:24 INFO - 'NO_EM_RESTART': '1', 05:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:24 INFO - 'PWD': '/builds/slave/test', 05:53:24 INFO - 'SHELL': '/bin/bash', 05:53:24 INFO - 'SHLVL': '1', 05:53:24 INFO - 'TERM': 'linux', 05:53:24 INFO - 'TMOUT': '86400', 05:53:24 INFO - 'USER': 'cltbld', 05:53:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:24 INFO - '_': '/tools/buildbot/bin/python'} 05:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:24 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:26 INFO - warning: no files found matching '*.txt' 05:53:26 INFO - no previously-included directories found matching 'build' 05:53:26 INFO - no previously-included directories found matching 'dist' 05:53:26 INFO - no previously-included directories found matching '.git*' 05:53:26 INFO - Installing collected packages: jsonschema, functools32 05:53:27 INFO - Running setup.py install for functools32 05:53:27 INFO - warning: no files found matching '*.txt' 05:53:27 INFO - no previously-included directories found matching 'build' 05:53:27 INFO - no previously-included directories found matching 'dist' 05:53:27 INFO - no previously-included directories found matching '.git*' 05:53:27 INFO - Successfully installed jsonschema functools32 05:53:27 INFO - Cleaning up... 05:53:27 INFO - Return code: 0 05:53:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:27 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')]} 05:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 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')]} 05:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:27 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 05:53:27 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 05:53:27 INFO - Using env: {'DISPLAY': ':0', 05:53:27 INFO - 'HOME': '/home/cltbld', 05:53:27 INFO - 'LANG': 'en_US.UTF-8', 05:53:27 INFO - 'LANGUAGE': 'en_US:en', 05:53:27 INFO - 'LOGNAME': 'cltbld', 05:53:27 INFO - 'MAIL': '/var/mail/cltbld', 05:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:27 INFO - 'MOZ_NO_REMOTE': '1', 05:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:27 INFO - 'NO_EM_RESTART': '1', 05:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:27 INFO - 'PWD': '/builds/slave/test', 05:53:27 INFO - 'SHELL': '/bin/bash', 05:53:27 INFO - 'SHLVL': '1', 05:53:27 INFO - 'TERM': 'linux', 05:53:27 INFO - 'TMOUT': '86400', 05:53:27 INFO - 'USER': 'cltbld', 05:53:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:27 INFO - '_': '/tools/buildbot/bin/python'} 05:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:27 INFO - Cleaning up... 05:53:27 INFO - Return code: 0 05:53:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:27 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')]} 05:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 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')]} 05:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:27 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 05:53:27 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 05:53:27 INFO - Using env: {'DISPLAY': ':0', 05:53:27 INFO - 'HOME': '/home/cltbld', 05:53:27 INFO - 'LANG': 'en_US.UTF-8', 05:53:27 INFO - 'LANGUAGE': 'en_US:en', 05:53:27 INFO - 'LOGNAME': 'cltbld', 05:53:27 INFO - 'MAIL': '/var/mail/cltbld', 05:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:27 INFO - 'MOZ_NO_REMOTE': '1', 05:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:27 INFO - 'NO_EM_RESTART': '1', 05:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:27 INFO - 'PWD': '/builds/slave/test', 05:53:27 INFO - 'SHELL': '/bin/bash', 05:53:27 INFO - 'SHLVL': '1', 05:53:27 INFO - 'TERM': 'linux', 05:53:27 INFO - 'TMOUT': '86400', 05:53:27 INFO - 'USER': 'cltbld', 05:53:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:27 INFO - '_': '/tools/buildbot/bin/python'} 05:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:27 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 05:53:27 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 05:53:27 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 05:53:27 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 05:53:27 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 05:53:27 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 05:53:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:29 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 05:53:29 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 05:53:29 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 05:53:29 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 05:53:29 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 05:53:29 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 05:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05: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 05: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 05: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 05: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 05: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 05: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 05:53:30 INFO - Downloading docopt-0.6.1.tar.gz 05:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:30 INFO - Running setup.py install for blobuploader 05:53:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:30 INFO - Running setup.py install for requests 05:53:30 INFO - Running setup.py install for docopt 05:53:31 INFO - Successfully installed blobuploader requests docopt 05:53:31 INFO - Cleaning up... 05:53:31 INFO - Return code: 0 05:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:31 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')]} 05:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:31 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')]} 05:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:31 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:31 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 05:53:31 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 05:53:31 INFO - Using env: {'DISPLAY': ':0', 05:53:31 INFO - 'HOME': '/home/cltbld', 05:53:31 INFO - 'LANG': 'en_US.UTF-8', 05:53:31 INFO - 'LANGUAGE': 'en_US:en', 05:53:31 INFO - 'LOGNAME': 'cltbld', 05:53:31 INFO - 'MAIL': '/var/mail/cltbld', 05:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:31 INFO - 'MOZ_NO_REMOTE': '1', 05:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:31 INFO - 'NO_EM_RESTART': '1', 05:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:31 INFO - 'PWD': '/builds/slave/test', 05:53:31 INFO - 'SHELL': '/bin/bash', 05:53:31 INFO - 'SHLVL': '1', 05:53:31 INFO - 'TERM': 'linux', 05:53:31 INFO - 'TMOUT': '86400', 05:53:31 INFO - 'USER': 'cltbld', 05:53:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:31 INFO - '_': '/tools/buildbot/bin/python'} 05:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:31 INFO - Running setup.py (path:/tmp/pip-FgWvgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:31 INFO - Running setup.py (path:/tmp/pip-EcB9bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:31 INFO - Running setup.py (path:/tmp/pip-FgVTDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:31 INFO - Running setup.py (path:/tmp/pip-9QWJMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:31 INFO - Running setup.py (path:/tmp/pip-iMjycc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:31 INFO - Running setup.py (path:/tmp/pip-G9OQRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:31 INFO - Running setup.py (path:/tmp/pip-cQVKsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:31 INFO - Running setup.py (path:/tmp/pip-_N3Snw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:31 INFO - Running setup.py (path:/tmp/pip-XgaBid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:31 INFO - Running setup.py (path:/tmp/pip-aoz9dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:32 INFO - Running setup.py (path:/tmp/pip-yKzdQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:32 INFO - Running setup.py (path:/tmp/pip-NbD4Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:32 INFO - Running setup.py (path:/tmp/pip-Lqb9Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:32 INFO - Running setup.py (path:/tmp/pip-WH0t2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:32 INFO - Running setup.py (path:/tmp/pip-531TWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:32 INFO - Running setup.py (path:/tmp/pip-ZFZ8Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:32 INFO - Running setup.py (path:/tmp/pip-aCy10p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:32 INFO - Running setup.py install for manifestparser 05:53:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:32 INFO - Running setup.py install for mozcrash 05:53:32 INFO - Running setup.py install for mozdebug 05:53:32 INFO - Running setup.py install for mozdevice 05:53:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:32 INFO - Running setup.py install for mozfile 05:53:33 INFO - Running setup.py install for mozhttpd 05:53:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Running setup.py install for mozinfo 05:53:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Running setup.py install for mozInstall 05:53:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Running setup.py install for mozleak 05:53:33 INFO - Running setup.py install for mozlog 05:53:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Running setup.py install for moznetwork 05:53:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Running setup.py install for mozprocess 05:53:33 INFO - Running setup.py install for mozprofile 05:53:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:33 INFO - Running setup.py install for mozrunner 05:53:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:34 INFO - Running setup.py install for mozscreenshot 05:53:34 INFO - Running setup.py install for moztest 05:53:34 INFO - Running setup.py install for mozversion 05:53:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:34 INFO - Cleaning up... 05:53:34 INFO - Return code: 0 05:53:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05: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')]} 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:34 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 05:53:34 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 05:53:34 INFO - Using env: {'DISPLAY': ':0', 05:53:34 INFO - 'HOME': '/home/cltbld', 05:53:34 INFO - 'LANG': 'en_US.UTF-8', 05:53:34 INFO - 'LANGUAGE': 'en_US:en', 05:53:34 INFO - 'LOGNAME': 'cltbld', 05:53:34 INFO - 'MAIL': '/var/mail/cltbld', 05:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:34 INFO - 'MOZ_NO_REMOTE': '1', 05:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:34 INFO - 'NO_EM_RESTART': '1', 05:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:34 INFO - 'PWD': '/builds/slave/test', 05:53:34 INFO - 'SHELL': '/bin/bash', 05:53:34 INFO - 'SHLVL': '1', 05:53:34 INFO - 'TERM': 'linux', 05:53:34 INFO - 'TMOUT': '86400', 05:53:34 INFO - 'USER': 'cltbld', 05:53:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:34 INFO - '_': '/tools/buildbot/bin/python'} 05:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:34 INFO - Running setup.py (path:/tmp/pip-78Kl_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:34 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)) 05:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:34 INFO - Running setup.py (path:/tmp/pip-h3VruC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:34 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)) 05:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:34 INFO - Running setup.py (path:/tmp/pip-j5vXh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:34 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)) 05:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:34 INFO - Running setup.py (path:/tmp/pip-Q57ieU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:34 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)) 05:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:34 INFO - Running setup.py (path:/tmp/pip-LkkYVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:34 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)) 05:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:34 INFO - Running setup.py (path:/tmp/pip-ZvcB4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:35 INFO - Running setup.py (path:/tmp/pip-U5I64p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:35 INFO - Running setup.py (path:/tmp/pip-8udvAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:35 INFO - Running setup.py (path:/tmp/pip-3GNszi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:35 INFO - Running setup.py (path:/tmp/pip-ff3DUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:35 INFO - Running setup.py (path:/tmp/pip-TR0whf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:35 INFO - Running setup.py (path:/tmp/pip-js4wUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:35 INFO - Running setup.py (path:/tmp/pip-e9e8rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:35 INFO - Running setup.py (path:/tmp/pip-R9hliX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:35 INFO - Running setup.py (path:/tmp/pip-Gt2nyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:35 INFO - Running setup.py (path:/tmp/pip-EJIJp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:35 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)) 05:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:35 INFO - Running setup.py (path:/tmp/pip-CZYulI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:35 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)) 05:53:35 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)) 05:53:35 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)) 05:53:35 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)) 05:53:35 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)) 05:53:35 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)) 05:53:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05: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 05: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 05: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 05: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 05: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 05: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 05:53:37 INFO - Downloading blessings-1.6.tar.gz 05:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:37 INFO - Installing collected packages: blessings 05:53:37 INFO - Running setup.py install for blessings 05:53:37 INFO - Successfully installed blessings 05:53:37 INFO - Cleaning up... 05:53:37 INFO - Return code: 0 05:53:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:38 INFO - Reading from file tmpfile_stdout 05:53:38 INFO - Current package versions: 05:53:38 INFO - argparse == 1.2.1 05:53:38 INFO - blessings == 1.6 05:53:38 INFO - blobuploader == 1.2.4 05:53:38 INFO - docopt == 0.6.1 05:53:38 INFO - functools32 == 3.2.3-2 05:53:38 INFO - jsonschema == 2.5.1 05:53:38 INFO - manifestparser == 1.1 05:53:38 INFO - mozInstall == 1.12 05:53:38 INFO - mozcrash == 0.17 05:53:38 INFO - mozdebug == 0.1 05:53:38 INFO - mozdevice == 0.48 05:53:38 INFO - mozfile == 1.2 05:53:38 INFO - mozhttpd == 0.7 05:53:38 INFO - mozinfo == 0.9 05:53:38 INFO - mozleak == 0.1 05:53:38 INFO - mozlog == 3.4 05:53:38 INFO - moznetwork == 0.27 05:53:38 INFO - mozprocess == 0.23 05:53:38 INFO - mozprofile == 0.28 05:53:38 INFO - mozrunner == 6.12 05:53:38 INFO - mozscreenshot == 0.1 05:53:38 INFO - mozsystemmonitor == 0.3 05:53:38 INFO - moztest == 0.7 05:53:38 INFO - mozversion == 1.4 05:53:38 INFO - psutil == 3.1.1 05:53:38 INFO - requests == 1.2.3 05:53:38 INFO - wsgiref == 0.1.2 05:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:38 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 05:53:38 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 05:53:38 INFO - Using env: {'DISPLAY': ':0', 05:53:38 INFO - 'HOME': '/home/cltbld', 05:53:38 INFO - 'LANG': 'en_US.UTF-8', 05:53:38 INFO - 'LANGUAGE': 'en_US:en', 05:53:38 INFO - 'LOGNAME': 'cltbld', 05:53:38 INFO - 'MAIL': '/var/mail/cltbld', 05:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:38 INFO - 'MOZ_NO_REMOTE': '1', 05:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:38 INFO - 'NO_EM_RESTART': '1', 05:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:38 INFO - 'PWD': '/builds/slave/test', 05:53:38 INFO - 'SHELL': '/bin/bash', 05:53:38 INFO - 'SHLVL': '1', 05:53:38 INFO - 'TERM': 'linux', 05:53:38 INFO - 'TMOUT': '86400', 05:53:38 INFO - 'USER': 'cltbld', 05:53:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:38 INFO - '_': '/tools/buildbot/bin/python'} 05:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 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)) 05:53:38 INFO - Cleaning up... 05:53:38 INFO - Return code: 0 05:53:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 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 0x7f3103191f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, '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': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', '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 05:53:38 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 05:53:38 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 05:53:38 INFO - Using env: {'DISPLAY': ':0', 05:53:38 INFO - 'HOME': '/home/cltbld', 05:53:38 INFO - 'LANG': 'en_US.UTF-8', 05:53:38 INFO - 'LANGUAGE': 'en_US:en', 05:53:38 INFO - 'LOGNAME': 'cltbld', 05:53:38 INFO - 'MAIL': '/var/mail/cltbld', 05:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:38 INFO - 'MOZ_NO_REMOTE': '1', 05:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:38 INFO - 'NO_EM_RESTART': '1', 05:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:38 INFO - 'PWD': '/builds/slave/test', 05:53:38 INFO - 'SHELL': '/bin/bash', 05:53:38 INFO - 'SHLVL': '1', 05:53:38 INFO - 'TERM': 'linux', 05:53:38 INFO - 'TMOUT': '86400', 05:53:38 INFO - 'USER': 'cltbld', 05:53:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:38 INFO - '_': '/tools/buildbot/bin/python'} 05:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:38 INFO - Cleaning up... 05:53:38 INFO - Return code: 0 05:53:38 INFO - Running post-action listener: _resource_record_post_action 05:53:38 INFO - Running post-action listener: _start_resource_monitoring 05:53:38 INFO - Starting resource monitoring. 05:53:38 INFO - [mozharness: 2016-10-04 12:53:38.815289Z] Finished create-virtualenv step (success) 05:53:38 INFO - [mozharness: 2016-10-04 12:53:38.815752Z] Running install step. 05:53:38 INFO - Running pre-action listener: _resource_record_pre_action 05:53:38 INFO - Running main action method: install 05:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:39 INFO - Reading from file tmpfile_stdout 05:53:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:39 INFO - Reading from file tmpfile_stdout 05:53:39 INFO - Output received: 05:53:39 INFO - Usage: mozinstall [options] installer 05:53:39 INFO - Options: 05:53:39 INFO - -h, --help show this help message and exit 05:53:39 INFO - -d DEST, --destination=DEST 05:53:39 INFO - Directory to install application into. [default: 05:53:39 INFO - "/builds/slave/test"] 05:53:39 INFO - --app=APP Application being installed. [default: firefox] 05:53:39 INFO - mkdir: /builds/slave/test/build/application 05:53:39 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'] 05:53:39 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 05:53:56 INFO - Reading from file tmpfile_stdout 05:53:56 INFO - Output received: 05:53:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:56 INFO - Running post-action listener: _resource_record_post_action 05:53:56 INFO - [mozharness: 2016-10-04 12:53:56.131844Z] Finished install step (success) 05:53:56 INFO - [mozharness: 2016-10-04 12:53:56.132097Z] Running run-tests step. 05:53:56 INFO - Running pre-action listener: _resource_record_pre_action 05:53:56 INFO - Running main action method: run_tests 05:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:56 INFO - Python 2.7.3 05:53:56 INFO - Return code: 0 05:53:56 INFO - grabbing minidump binary from tooltool 05:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:56 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 0x101b790>, '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 0x101c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:56 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 05:53:56 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 05:53:56 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 05:53:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:56 INFO - Return code: 0 05:53:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 05:53:56 INFO - Using env: {'DISPLAY': ':0', 05:53:56 INFO - 'HOME': '/home/cltbld', 05:53:56 INFO - 'LANG': 'en_US.UTF-8', 05:53:56 INFO - 'LANGUAGE': 'en_US:en', 05:53:56 INFO - 'LOGNAME': 'cltbld', 05:53:56 INFO - 'MAIL': '/var/mail/cltbld', 05:53:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:56 INFO - 'MOZ_NO_REMOTE': '1', 05:53:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:56 INFO - 'NO_EM_RESTART': '1', 05:53:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:56 INFO - 'PWD': '/builds/slave/test', 05:53:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:56 INFO - 'SHELL': '/bin/bash', 05:53:56 INFO - 'SHLVL': '1', 05:53:56 INFO - 'TERM': 'linux', 05:53:56 INFO - 'TMOUT': '86400', 05:53:56 INFO - 'USER': 'cltbld', 05:53:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475584707.264093-877291153', 05:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:56 INFO - '_': '/tools/buildbot/bin/python'} 05:53:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:53:56 INFO - mozversion application_buildid: 20161004030204 05:53:56 INFO - mozversion application_changeset: 42c95d88aaaa7c2eca1d278399421d437441ac4d 05:53:56 INFO - mozversion application_display_name: Nightly 05:53:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:56 INFO - mozversion application_name: Firefox 05:53:56 INFO - mozversion application_remotingname: firefox 05:53:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:56 INFO - mozversion application_vendor: Mozilla 05:53:56 INFO - mozversion application_version: 52.0a1 05:53:56 INFO - mozversion platform_buildid: 20161004030204 05:53:56 INFO - mozversion platform_changeset: 42c95d88aaaa7c2eca1d278399421d437441ac4d 05:53:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:56 INFO - mozversion platform_version: 52.0a1 05:53:56 INFO - using testdate: 1475585636 05:53:56 INFO - actual date: 1475585636 05:53:56 INFO - starting webserver on 'localhost:36008' 05:53:56 INFO - SUITE-START | Running 2 tests 05:53:56 INFO - TEST-START | dromaeo_css 05:53:56 INFO - operating with platform_type : linux_ 05:53:56 INFO - Initialising browser for dromaeo_css test... 05:53:56 INFO - TEST-INFO | started process 27787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7x1gZz/profile http://localhost:36008/getInfo.html) 05:54:01 INFO - PROCESS | 27787 | __metrics Screen width/height:1600/1200 05:54:01 INFO - PROCESS | 27787 | colorDepth:24 05:54:01 INFO - PROCESS | 27787 | Browser inner width/height: 1024/697 05:54:01 INFO - PROCESS | 27787 | __metrics 05:54:02 INFO - PROCESS | 27787 | 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" 05:54:02 INFO - PROCESS | 27787 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:02 INFO - PROCESS | 27787 | console.error: PushService: 05:54:02 INFO - PROCESS | 27787 | stateChangeProcessEnqueue: Error transitioning state 05:54:02 INFO - PROCESS | 27787 | UnknownError 05:54:03 INFO - TEST-INFO | 27787: exit 0 05:54:03 INFO - Browser initialized. 05:54:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:03 INFO - TEST-INFO | started process 27872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7x1gZz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:15 INFO - PROCESS | 27872 | RSS: Main: 178774016 05:54:15 INFO - PROCESS | 27872 | 05:55:07 INFO - PROCESS | 27872 | 1475585707111 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] 05:57:17 INFO - PROCESS | 27872 | Cycle 1(1): loaded http://localhost:36008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36008/tests/dromaeo/cssquery-ext.html) 05:57:19 INFO - PROCESS | 27872 | RSS: Main: 315076608 05:57:19 INFO - PROCESS | 27872 | 06:00:21 INFO - PROCESS | 27872 | Cycle 1(1): loaded http://localhost:36008/tests/dromaeo/cssquery-ext.html (next: http://localhost:36008/tests/dromaeo/cssquery-jquery.html) 06:00:22 INFO - PROCESS | 27872 | RSS: Main: 278450176 06:00:22 INFO - PROCESS | 27872 | 06:03:24 INFO - PROCESS | 27872 | Cycle 1(1): loaded http://localhost:36008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36008/tests/dromaeo/cssquery-mootools.html) 06:03:24 INFO - PROCESS | 27872 | RSS: Main: 217042944 06:03:24 INFO - PROCESS | 27872 | 06:06:26 INFO - PROCESS | 27872 | Cycle 1(1): loaded http://localhost:36008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36008/tests/dromaeo/cssquery-prototype.html) 06:06:27 INFO - PROCESS | 27872 | RSS: Main: 224256000 06:06:27 INFO - PROCESS | 27872 | 06:09:29 INFO - PROCESS | 27872 | Cycle 1(1): loaded http://localhost:36008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36008/tests/dromaeo/cssquery-yui.html) 06:09:30 INFO - PROCESS | 27872 | RSS: Main: 217907200 06:09:30 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | Cycle 1(1): loaded http://localhost:36008/tests/dromaeo/cssquery-yui.html (next: http://localhost:36008/tests/dromaeo/cssquery-dojo.html) 06:12:33 INFO - PROCESS | 27872 | RSS: Main: 310370304 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | __start_tp_report 06:12:33 INFO - PROCESS | 27872 | _x_x_mozilla_page_load 06:12:33 INFO - PROCESS | 27872 | _x_x_mozilla_page_load_details 06:12:33 INFO - PROCESS | 27872 | |i|pagename|runs| 06:12:33 INFO - PROCESS | 27872 | |0;dojo.html;2980.2251414632196;3000.594919685842;3005.459017376872;3035.453618348699;3051.3897220555896;5130.769115389807;5186.7147306898105;5202.4277329493725;5211.5309622134;5275.894482110355;5264.6051546134;5287.524122828935;5296.841094767163;5351.678899266037;5418.783248670048;4748.240281554952;4797.0645724083815;4812.807487700487;4824.951750482503;4833.806647734086;4886.36477257956;4923.679960802554;4926.507349265081;4929.778159982791;4950.529699678543;4606.585407313358;4664.836730714443;4669.743164125972;4838.29844672524;4884.267359896026;4779;4796.880077998043;4809.639277054235;4816.422029356465;4842.782074806642;4771.5467030632035;4774.80900763969;4778.928316075262;4786.186348320759;4838.637102217348;5041.798328066873;5074.086664400406;5287.365516138049;5289.391719952217;5344.198370244456;5506.476884695988;5597.44025597437;5600.131979543136;5703.942960570383;5708.229389032469;5661.575381846378;5672.68800215988;5676.971615141898;5735.885282294331;5739.62692424991;5225.764840582183;5261.894762104736;5273.947260527384;5278.076336641073;5310.097283461821;5521.3926468088475;5528.889422211533;5738.512226460798;5762.2221000164445;5790.160426738099;5562.415946325658;5568.387477377485;5606.971965140148;5675.1487276907965;5676.574256930747;5677.630953987978;5683;5685;5685.971570142206;5709.25779648643;5399.70301633414;5501.284832971768;5660.858478537987;5663.093904975184;5666.744996475169;5473.0969390051;5527.723613819293;5547.5007249347755;5578.581606379456;5640.041192997201;4321.805518751664;4328.870133895925;4336.241157797436;4376.474823021258;4380.014496738272;3809.066778639251;3845.0964023454467;3858.8456461741216;3863.6522712955407;3902.414637804352;5183.533481986639;5280.155175171954;5290.15357542799;5361.115415956401;5393.43368946255;5733.082706766897;5736.741846616912;5742.598018138774;5743.655380677173;5764.682942438206;5367.677939323653;5387.595930305243;5406.540444062299;5413.106837371868;5414.35027796667;4737.715737055788;4741.502142275081;4817.397825271841;4882.12121818069;4960.330355402047;5889.764409423747;5896.262967129109;5900.527957763283;5932.673702946293;5944.64332140073;5708.286464191976;5708.743106560131;5715.5713321500225;5721.7425215866215;5726.940516004553;5606.074997625346;5643.548516118783;5822.592418530662;5848.093545500455;5849.268841394825;5568.303962004749;5609.943900561106;5613.354464236501;5655.519280861173;5675.914861277167;5659.745311460912;5723.255976723;5729.942700572941;5731.168980497721;5732.283464566929;5314.362276526842;5381.623286369917;5501.862453438536;5576.749046292845;5579;5400.054990376747;5470.370907345547;5472.042392581362;5496.120620700669;5537.723113844372;5414;5415.566754659697;5423.945760542344;5430.511253987002;5431.891362172813;5336;5504.119340905436;5504.862378440571;5517.613767036269;5550.666959982414;5272.446393128666;5324.520793128637;5369.167778994262;5385.730713464232;5450.2369668247275 06:12:33 INFO - PROCESS | 27872 | |1;ext.html;550.8228460793805;583.3204316970729;602.6655206360474;603.9642013946079;613.6870196199939;32009;32740;34967.475487867705;34973.82513087434;43651.56348436515;42134;46059.76970115145;46217;46268.53731462693;46289.30566041503;8867.645294188225;9010.369274150811;9024.819503609924;9027.14242146995;9036.412633178823;8852.778680532974;8923.598438070303;8931.64273429062;8935.55322233889;8952.194302512773;8954.910450895506;9017;9018.86471702925;9020.503872287021;9021.503817290046;8905.287576993858;8945.59744811485;8951.373403861733;8951.41815781972;8958.283337332998;8924.393609150351;8991.955040224822;8995.370324077317;8999.325050621164;9002.909970900273;41200.587994119975;41562.37656435156;41588.79205603953;41631;41676;3371.645977172386;3663.157473781045;3917.882463526099;4088.9795551022053;4155.792210389499;30691.925782597504;31867.52198717021;31880;32022.679773202202;32163.19592010195;4266.338717498793;4364.301711726109;4378.1462614790125;4569.497355290915;4579.5878370946775;325492;327287;327674;328815;329073;56333.43666563364;56501.7174914131;56669.71665141648;56705.14942275869;56711.14933276004;60416;60498;60599;60621;60710;16206;16211.27049282785;16467.670646587;16469.91765041191;16474.58813529671;11801.29192248468;11827.397972446048;11830.881691182978;11831.230969986924;11854.703632409259;15534.844651553565;16352;16448.917755411145;16556.337746490248;16698;5003.346218772764;5633.267675202197;5720.48515633595;5738.885222295614;5920.407959204132;943.9292053095908;945.7257395355269;975.7560609847538;983.090641156927;1039.1686650679426;30837;30891.691083089332;30923.536146957813;31548.36903261922;31766.682333176836;1015.3298822776932;1021.6015753856002;1067.5783065689166;1147.391882302381;1167.9357635329968;15032.473863414729;15955.920220398824;15959.281832317574;15962.36150553988;16230.269637866324;486653;488421;489697;489910;490395;55245;55313.72343138339;55395;55514.72242638761;55577.72211138919;1228.993855030737;1254.2223821230714;1310.0829419406264;1342.6039318401095;1353.1069494133824;28437.43125137527;30044.849775751856;30345.848270758506;30579;31103.533446998765;47897.76051119861;48228;48380;48417.75791121022;48430.757846210545;385172;385991;386688;386845;388102;26916.596251056642;27265.591016134378;27621.30946726348;27673.308167295978;28713;46075;46105.07789844251;46128;46150.30774538317;46769;38268;39143.41284880786;39783;40163.39754903737;41146.794266028475;38412.61587384091;38560.42159367556;39119.608803912735;39886.60113398829;40959.38560921648;38769.80615096907;39648.40527392034;39999.400008999306;40226.59773402228;40452.1909561813;30551;34223.48664769981;35074.473882892285;37617;38675;27141.457170856866;27685;27851.58222626622;27976.06251343661;27978.44043119167 06:12:33 INFO - PROCESS | 27872 | |2;jquery.html;386.6829200055955;404.59944654791764;408.6220246272198;410.8870060733298;426.1285670803207;13263.602091937246;15350.462733804305;18872;19332;19675.60648787027;18712.345067922626;18830.15264313106;19164.520886977796;19167.616647667037;19176.137073831676;5096.949030509703;5717.714114294289;5801.941980580204;6055.9697201514155;6056.909146362808;5901.645901245939;5939.1388248703915;5995.460408563228;5997.6701281429505;6000.33996260411;5730.4269573042575;5811.912821307684;5832.737526811283;5960.135780311853;5966.478547970261;5840.065589505659;5861.413858614147;5909.497692696126;5914.319853216892;5916.97041514794;5154.742262886841;5318.707471089088;5451.209574611698;5510.614257002011;5577.69322687252;13952.511662091778;14007.229602371866;14194.787078193835;21233.071881701933;21948.670769938464;2150.2044243629803;2266.240809328877;2272.749997500274;2524.1587382193525;2599.233226198276;10134.13859821916;10541.420221887793;10724.731881702943;12325.5069797208;13563.796543051862;1853.4347024157626;1933.5166208447888;1945.3815902421484;1967.1541237267968;1989.263972330247;78786.21213787847;78980.60509697472;79043;79897.60051199707;80992.59503702502;10931.781364372668;11052.778944421067;11184.161187910777;11259.437028148559;11371.849275014725;15401.691966160613;15498;16023.839761602469;16211.189440528162;16220.270087846075;6480.481561475165;6616.768413105518;7657.387409007266;7848.646810893523;8393.874091888505;7231.963840180765;7621.199774023758;7628.923710762932;7816.921830781733;7900.9604951976025;4797.376341075638;4880.267959806058;4881.926771098437;4950.3069570260195;4967.428745694219;1961.3723608445162;1989.532459871929;2026.1692705990474;2057.722207501998;2075.1803037800287;853.8804567360575;932.3100905330007;991.7421470417744;1009.8636684047707;1075.774087441646;18208.998505082083;19272.518187045436;19358.128884200243;19391.576052993376;19890.30383936555;936.9859452108224;960.3037797596826;988.5551501824208;990.7968866382519;999.2655398282257;9675.758106047406;10694.580005178997;10724.41015744126;10733.302335348177;10775.976282253174;401251;405003;406711;411019;412942;54527;66461.6676916622;84447.57776211202;85529;87796.12203878007;951.6383774165772;954.8615450759601;992.6079198716467;993.1973468155275;994.4381424495137;17034.101189018467;17649.117544123;18093.562223177552;18127.27490900402;18261.452156435327;37179.6282037187;41425;41615.7919210402;41662.58337416708;42728.78635606802;46698;56642.433575663716;56960.71519642375;57273;57722.711386442796;7969.521828690297;8078.394120441108;8313.584320784057;8380.329573633973;8660.956695216484;11560.768784624091;12615.93692031534;12661.987041036511;12677.30274834856;12709.745805084032;9940.801183976424;10506.579736810747;10860.728481788019;10894.202456594574;11128.666140015812;11076.501557429774;11391.316521008766;11465.598704045318;11509.597164099216;11567.710807229887;11142.387168705798;11194.160437967023;11208.383538905438;11211.495482703462;11642.592509262135;8159.061707903667;8223.21879421454;8381.11998240176;8552.828943421222;8822.86765698528;8666.826663466569;10085.747856303651;10368.326058806153;10399.307972239141;10447.05976462122 06:12:33 INFO - PROCESS | 27872 | |3;mootools.html;1316.4141956829214;1383.3429121167446;1456.3228098933996;1498.527963691438;1738.756574079629;7695.730649427272;8680.8697869532;9040.54797260136;9045.09549045095;9318.114779095975;9082.95458522708;9163.312751543628;9169.77075573111;9173.403728757627;9173.449593024423;2358.8938497767554;2378.9286321410386;2382.7498112698177;2386.081358676913;2388.2118900762794;2324.6164382876805;2367.3253122859987;2381.738008819037;2382.4520360317138;2386.152915714922;2382.3805810489225;2384.3562238195677;2386.7016622922133;2433.7201221859536;2439.231642032763;2335.089315167086;2340.2394221877958;2349.1073392110975;2351.447409858682;2375.406148462884;2323.070771691337;2335.0309621507054;2344.753800850903;2346.9530609387716;2351.564960482316;8957.462552246887;8979.102089791035;9013.594388252544;9029.63881444748;9109.726708198765;5188.584913206934;5203.583713302926;5365.704886231256;5366.356037275552;5367.973160134214;3367.545381373532;3468.4103702370403;3546.29074185164;3557.1107223194203;3577.409727394977;1111.6776134920863;1144.210494758614;1194.546072492456;1218.0499210615646;1234.0559472003924;12202.779722027815;12224.816627750592;12246.571370002008;12268.570600029045;12271.754564908651;4472.955270447319;4527.139843429738;4652;4672.556107169813;4764.595009424238;9657.082577155159;9677.516124193762;9697.272704547187;9701.175400091071;9704.563294651616;5206.739663016834;5231.346081739783;5238.6594871334;5244.816431424958;5245.160774276097;4223.5142958559545;4349.282368409177;4807.759612019385;4894.412670479565;4926.507349265116;3772.981135094362;3773.471713960048;3843.55799083109;3905.804709764557;3911.3155197840265;1184.1829137894824;1186.928784272929;1195.0081432411077;1205.4274219745726;1208.4682739594725;839.7900524868783;841.6885752271576;847.6778824046822;884.4339622641514;905.1175104273412;5311.548518375904;5501.301921884687;5548.55611551075;5633.718314084279;5644.8871022579315;424.91501699659574;428.8499025341168;439.6175327465062;439.82846689791006;454.3525476196407;3769.6984241260634;3821.770693758328;3856.2094770571966;3860.9806950965067;3892.380086519564;10719.303245289031;11366.204365694322;11436.94281528587;11466.827997580043;11471.082313414907;11120.110391168688;11393.202475826778;11423.942880285711;11429.314241145392;11434.485448154854;8400.579971001425;8496.915030849736;8518.659253629785;8545.48727076365;8545.487270763773;5395.190721391823;5427.48438898304;5526.530244929226;5539.14143307788;5672.971635141798;10302.536385862504;10424.739381515219;10446.164306855586;10478.161747060369;10595.09941654968;10351.223658225512;10539.209559282932;10741.785164296827;10949.726256843323;10951.780964380509;6552.541322107407;6773.254941956282;7252.528585641917;7738.651760670896;7811.414143939113;8379.413441059067;8813.42712723671;8820.603072861864;8827.911720882708;8830.558472076498;7767.883481747665;7801.1808760079375;7883.6846526138315;7933.722319718782;8056.154103819014;7456.47804653669;7577.696892124253;7582.241775822374;7587.355074818703;7711.8072048197;6595.505337099833;6709.93290067093;6711.697973591103;6719;6721.092652491851;4568.657350698777;4697.577218050392;4722.197226471577;4740.834070807505;4791.089692958327;4553.681242313006;4601.976990115028;4625.375574297427;4694;4895.4370247422 06:12:33 INFO - PROCESS | 27872 | |4;prototype.html;333.77704488109197;337.84627994262615;347.9860805567777;350.3973166154214;350.8824543777836;5055.266986286986;5189.8183563575285;5237.685738855666;5281.471852814717;5296.841094767158;4982.153033984222;5084.720340381286;5106.387233531981;5109.131447653898;5113.693178409298;4059.320848240162;4080.367543030835;4084.4077608746716;4088.8568900088503;4092.815823287959;3834.482344883447;3849.191669749356;4076.694247931402;4094.6724262058965;4113.4858142732155;4047.311956967308;4047.5750046245016;4057.6753859691303;4067.9796601016956;4078.775667338295;4055.614716601918;4073.775942323171;4077.9592204077876;4085.9591404085877;4089.1208390196102;3672.3022625701296;3680.5583330000572;3681.871134510306;3683.7605555639066;3688.17016171362;4864.902701945976;4966.826161084345;4974.801007959677;4976.62675299354;5000.42495113063;4645.953540464586;4646.372739680134;4656.930146047812;4660.650451216138;4666.5533684557895;5327.440618735054;5338.199270109515;5341.4658534146665;5342.679439233659;5377.3009508764;3851.287511810296;3920.5491368492417;3948.605139486057;3948.605139486057;3961.8217180226957;5476.096444086721;5511.338639363262;5544.584156188343;5547.417521160301;5553.416891226403;4069.491313585802;4076.408920706481;4088.9795551022053;4096.3036283831225;4109.835606575703;3828.693704503633;4012.398140278923;4054.8580799671868;4144.295469770146;4160.793369922749;4533.886652833706;4538.977305113453;4582.725036497821;4589.737822098883;4596.724196548218;5336.519713225751;5341.786328546815;5346.492083252085;5389.272448219519;5392.325959255093;1261.2621616354352;1308.378520202896;1327.674719693662;1397.986020139806;1414.4130185972706;890.3055616619048;899.321012635456;916.6883259691604;919.6459363145237;919.7516670498928;4571.748553829505;4573.565511276423;4583.166733306704;4599.862004139881;4609.539046095364;4814.855554333306;4845.878853028703;4868.2210846264425;4868.269759536027;4891.877703057452;4522.66080043998;4546.636269098464;4560.498345182027;4566.246569316092;4591.288350305708;2400.663907053014;2565.9486810264066;2571.0744132112422;2580.109862097573;2601.270155346711;4956.397891107125;4965.503449655005;4976.377952755905;4996.650234483552;5008.424031236382;4683.531646835358;4861.70829750209;4880.6095512358925;4881.536254055859;4902.362692849907;4907;4954.234781566108;4954.851354459372;4964.453910069889;4967.279744437109;4781.641376896816;4798.136335459651;4831.323614693875;4837.250226214942;4849.781759820887;4605.769711514478;4759.76201189946;4767.809287628456;4773.880652983703;4783.976080119577;4853.587445067209;4893.168161412497;4918.43438004634;4958.6281028923695;4973.900521989613;3637.672609465161;3643.635636436335;3646.106703857572;3646.3254297954963;3708.6847617952776;4869.732164730974;4885.338984745204;4906.95093049065;4912.803487860446;5321.6540924839765;4871.269309603588;5293.7353132344;5295.311609490742;5328.813491527778;5329.840104796862;5317.282166907418;5322.707251101227;5346.8395948121615;5352.090144675337;5441.238226648352;5170.870728231825;5255.78976840922;5282.207668849704;5365.302510673588;5371.5702743781185;5372.811951581833;5385.919211211756;5387.245785590099;5398.892022159614;5401.594880383908;5269.868253293698;5280.7326241702485;5298.920516192183;5328.17413300939;5330 06:12:33 INFO - PROCESS | 27872 | |5;yui.html;727.4689476682021;748.8652042632327;759.199045007517;792.9563873986929;800.3077338102543;14681.265936703163;16221.513354599381;16276.593085172877;16586.83413165868;16620.750688739678;15093.773593396081;15337.539873803777;15340.386384544632;15353.30910109045;15364.539063828102;661.3155384177377;674.9628770417625;761.603965937712;786.1116937860224;788.4874831359605;784.6469088909985;794.3962588432775;794.408165916393;794.7854079398559;797.5812698333364;845.7293666026874;846.022843615625;846.1665259719172;846.5259454705384;846.5682501924032;675.2841987493273;697.6860412814253;819.8852160697447;846.9280111190557;848.5969164646805;615.7660089166133;620.7051650466037;620.8106527509108;621.2079598511888;621.3134486392516;13499;13623.386947587382;13654.385552650154;13675.247861367621;13787.793183102161;14108.672069108585;14340.498082567061;14599.343029563695;14609.196494192814;14735.484258050918;13104.410301536454;13188.538401156009;13195.767037075882;13621.387037583332;13709.794353084711;4458.554144585515;4545.795439205243;4559.156556037144;4739.549742774431;4755.857324280277;76037;77495.6125219376;78058.60970695167;78616;80363.19636803615;11236.719082022852;11391.772164556829;11458.59894903691;11770.705732356588;11794.941025294818;21995.560088798135;22001;22003.669944950838;22005.779942200694;22006;7809.180036096242;7844.607769611611;7935.285824275843;8479.491230526064;8514.276286515591;4406.272964960745;4437.2234858899565;4456;4482.5069242383315;4572.4055872736335;3597.730170237243;3698.8335524901445;3704.0554658561896;3706.8331925063435;3708.9072773180887;616.3066550131102;626.2985456288985;640.2093414632925;642.8264368620446;659.591053546804;551.8620344913771;567.730328094152;604.8699529601157;679.4089142446104;690.3441730356082;9002.774930626787;9084.954575227082;9170.67902623405;9464.337496375325;9600.039996000343;546.6638017619135;563.2818156849967;568.46848196936;571.8227349521661;616.140484024783;4275.850345237964;4540.84107056258;4594.678372513892;4646.628269738413;4732.408448943882;63764;74153;97778.511107444;123227.3838630801;132444;106034;109561.45219273852;110046.44976775064;112410.43794780974;116616;93408.53295733478;94831;95734;96987.51506242424;100145;8592.914070859462;8756.956215218883;8890.822183556422;8915.375923685539;9180.495072770795;53074.4692553085;53304.4052070631;54199;54422;55415.72292138513;74415.25584744083;79210;82543.5872820632;84333.57833210795;86023.13976860151;11276.94361528187;11516.30902145874;11677.532898683958;11834.526618935146;12032.037437004843;12781.680457988625;12825.43545145823;12862.935685321514;13015.349232538147;13036.217826930415;11396.110858972464;11903.821442678194;11917.046636269251;11994.76010479803;12394.256344619353;11972.281663100242;12069.456874440846;12161.209521381083;12580.87419125797;12600.810987835373;11295.866418259773;11673;11741.530338786353;12105;12132.939335303266;8994;9214.631414743335;9330.673426430314;9378.812423751624;9424.198943089914;9127.543622818699;9435.57539910692;9644.421334719938;9713.36863103896;9797.951010244904 06:12:33 INFO - PROCESS | 27872 | __end_tp_report 06:12:33 INFO - PROCESS | 27872 | __start_cc_report 06:12:33 INFO - PROCESS | 27872 | _x_x_mozilla_cycle_collect,1238 06:12:33 INFO - PROCESS | 27872 | __end_cc_report 06:12:33 INFO - PROCESS | 27872 | __startTimestamp1475586753899__endTimestamp 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | ------- Summary: start ------- 06:12:33 INFO - PROCESS | 27872 | Number of tests: 6 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | [#0] dojo.html Cycles:165 Average:5239.80 Median:5414.00 stddev:600.22 (11.1%) stddev-sans-first:575.29 06:12:33 INFO - PROCESS | 27872 | Values: 2980.2 3000.6 3005.5 3035.5 3051.4 5130.8 5186.7 5202.4 5211.5 5275.9 5264.6 5287.5 5296.8 5351.7 5418.8 4748.2 4797.1 4812.8 4825.0 4833.8 4886.4 4923.7 4926.5 4929.8 4950.5 4606.6 4664.8 4669.7 4838.3 4884.3 4779.0 4796.9 4809.6 4816.4 4842.8 4771.5 4774.8 4778.9 4786.2 4838.6 5041.8 5074.1 5287.4 5289.4 5344.2 5506.5 5597.4 5600.1 5703.9 5708.2 5661.6 5672.7 5677.0 5735.9 5739.6 5225.8 5261.9 5273.9 5278.1 5310.1 5521.4 5528.9 5738.5 5762.2 5790.2 5562.4 5568.4 5607.0 5675.1 5676.6 5677.6 5683.0 5685.0 5686.0 5709.3 5399.7 5501.3 5660.9 5663.1 5666.7 5473.1 5527.7 5547.5 5578.6 5640.0 4321.8 4328.9 4336.2 4376.5 4380.0 3809.1 3845.1 3858.8 3863.7 3902.4 5183.5 5280.2 5290.2 5361.1 5393.4 5733.1 5736.7 5742.6 5743.7 5764.7 5367.7 5387.6 5406.5 5413.1 5414.4 4737.7 4741.5 4817.4 4882.1 4960.3 5889.8 5896.3 5900.5 5932.7 5944.6 5708.3 5708.7 5715.6 5721.7 5726.9 5606.1 5643.5 5822.6 5848.1 5849.3 5568.3 5609.9 5613.4 5655.5 5675.9 5659.7 5723.3 5729.9 5731.2 5732.3 5314.4 5381.6 5501.9 5576.7 5579.0 5400.1 5470.4 5472.0 5496.1 5537.7 5414.0 5415.6 5423.9 5430.5 5431.9 5336.0 5504.1 5504.9 5517.6 5550.7 5272.4 5324.5 5369.2 5385.7 5450.2 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | [#1] ext.html Cycles:180 Average:56067.96 Median:22270.59 stddev:107541.56 (482.9%) stddev-sans-first:107762.46 06:12:33 INFO - PROCESS | 27872 | Values: 550.8 583.3 602.7 604.0 613.7 32009.0 32740.0 34967.5 34973.8 43651.6 42134.0 46059.8 46217.0 46268.5 46289.3 8867.6 9010.4 9024.8 9027.1 9036.4 8852.8 8923.6 8931.6 8935.6 8952.2 8954.9 9017.0 9018.9 9020.5 9021.5 8905.3 8945.6 8951.4 8951.4 8958.3 8924.4 8992.0 8995.4 8999.3 9002.9 41200.6 41562.4 41588.8 41631.0 41676.0 3371.6 3663.2 3917.9 4089.0 4155.8 30691.9 31867.5 31880.0 32022.7 32163.2 4266.3 4364.3 4378.1 4569.5 4579.6 325492.0 327287.0 327674.0 328815.0 329073.0 56333.4 56501.7 56669.7 56705.1 56711.1 60416.0 60498.0 60599.0 60621.0 60710.0 16206.0 16211.3 16467.7 16469.9 16474.6 11801.3 11827.4 11830.9 11831.2 11854.7 15534.8 16352.0 16448.9 16556.3 16698.0 5003.3 5633.3 5720.5 5738.9 5920.4 943.9 945.7 975.8 983.1 1039.2 30837.0 30891.7 30923.5 31548.4 31766.7 1015.3 1021.6 1067.6 1147.4 1167.9 15032.5 15955.9 15959.3 15962.4 16230.3 486653.0 488421.0 489697.0 489910.0 490395.0 55245.0 55313.7 55395.0 55514.7 55577.7 1229.0 1254.2 1310.1 1342.6 1353.1 28437.4 30044.8 30345.8 30579.0 31103.5 47897.8 48228.0 48380.0 48417.8 48430.8 385172.0 385991.0 386688.0 386845.0 388102.0 26916.6 27265.6 27621.3 27673.3 28713.0 46075.0 46105.1 46128.0 46150.3 46769.0 38268.0 39143.4 39783.0 40163.4 41146.8 38412.6 38560.4 39119.6 39886.6 40959.4 38769.8 39648.4 39999.4 40226.6 40452.2 30551.0 34223.5 35074.5 37617.0 38675.0 27141.5 27685.0 27851.6 27976.1 27978.4 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | [#2] jquery.html Cycles:180 Average:25806.99 Median:409.75 stddev:67338.92 (16434.0%) stddev-sans-first:67500.77 06:12:33 INFO - PROCESS | 27872 | Values: 386.7 404.6 408.6 410.9 426.1 13263.6 15350.5 18872.0 19332.0 19675.6 18712.3 18830.2 19164.5 19167.6 19176.1 5096.9 5717.7 5801.9 6056.0 6056.9 5901.6 5939.1 5995.5 5997.7 6000.3 5730.4 5811.9 5832.7 5960.1 5966.5 5840.1 5861.4 5909.5 5914.3 5917.0 5154.7 5318.7 5451.2 5510.6 5577.7 13952.5 14007.2 14194.8 21233.1 21948.7 2150.2 2266.2 2272.7 2524.2 2599.2 10134.1 10541.4 10724.7 12325.5 13563.8 1853.4 1933.5 1945.4 1967.2 1989.3 78786.2 78980.6 79043.0 79897.6 80992.6 10931.8 11052.8 11184.2 11259.4 11371.8 15401.7 15498.0 16023.8 16211.2 16220.3 6480.5 6616.8 7657.4 7848.6 8393.9 7232.0 7621.2 7628.9 7816.9 7901.0 4797.4 4880.3 4881.9 4950.3 4967.4 1961.4 1989.5 2026.2 2057.7 2075.2 853.9 932.3 991.7 1009.9 1075.8 18209.0 19272.5 19358.1 19391.6 19890.3 937.0 960.3 988.6 990.8 999.3 9675.8 10694.6 10724.4 10733.3 10776.0 401251.0 405003.0 406711.0 411019.0 412942.0 54527.0 66461.7 84447.6 85529.0 87796.1 951.6 954.9 992.6 993.2 994.4 17034.1 17649.1 18093.6 18127.3 18261.5 37179.6 41425.0 41615.8 41662.6 42728.8 46698.0 56642.4 56960.7 57273.0 57722.7 7969.5 8078.4 8313.6 8380.3 8661.0 11560.8 12615.9 12662.0 12677.3 12709.7 9940.8 10506.6 10860.7 10894.2 11128.7 11076.5 11391.3 11465.6 11509.6 11567.7 11142.4 11194.2 11208.4 11211.5 11642.6 8159.1 8223.2 8381.1 8552.8 8822.9 8666.8 10085.7 10368.3 10399.3 10447.1 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | [#3] mootools.html Cycles:180 Average:5768.97 Median:4585.32 stddev:3396.72 (74.1%) stddev-sans-first:3389.77 06:12:33 INFO - PROCESS | 27872 | Values: 1316.4 1383.3 1456.3 1498.5 1738.8 7695.7 8680.9 9040.5 9045.1 9318.1 9083.0 9163.3 9169.8 9173.4 9173.4 2358.9 2378.9 2382.7 2386.1 2388.2 2324.6 2367.3 2381.7 2382.5 2386.2 2382.4 2384.4 2386.7 2433.7 2439.2 2335.1 2340.2 2349.1 2351.4 2375.4 2323.1 2335.0 2344.8 2347.0 2351.6 8957.5 8979.1 9013.6 9029.6 9109.7 5188.6 5203.6 5365.7 5366.4 5368.0 3367.5 3468.4 3546.3 3557.1 3577.4 1111.7 1144.2 1194.5 1218.0 1234.1 12202.8 12224.8 12246.6 12268.6 12271.8 4473.0 4527.1 4652.0 4672.6 4764.6 9657.1 9677.5 9697.3 9701.2 9704.6 5206.7 5231.3 5238.7 5244.8 5245.2 4223.5 4349.3 4807.8 4894.4 4926.5 3773.0 3773.5 3843.6 3905.8 3911.3 1184.2 1186.9 1195.0 1205.4 1208.5 839.8 841.7 847.7 884.4 905.1 5311.5 5501.3 5548.6 5633.7 5644.9 424.9 428.8 439.6 439.8 454.4 3769.7 3821.8 3856.2 3861.0 3892.4 10719.3 11366.2 11436.9 11466.8 11471.1 11120.1 11393.2 11423.9 11429.3 11434.5 8400.6 8496.9 8518.7 8545.5 8545.5 5395.2 5427.5 5526.5 5539.1 5673.0 10302.5 10424.7 10446.2 10478.2 10595.1 10351.2 10539.2 10741.8 10949.7 10951.8 6552.5 6773.3 7252.5 7738.7 7811.4 8379.4 8813.4 8820.6 8827.9 8830.6 7767.9 7801.2 7883.7 7933.7 8056.2 7456.5 7577.7 7582.2 7587.4 7711.8 6595.5 6709.9 6711.7 6719.0 6721.1 4568.7 4697.6 4722.2 4740.8 4791.1 4553.7 4602.0 4625.4 4694.0 4895.4 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | [#4] prototype.html Cycles:180 Average:4339.98 Median:4841.56 stddev:1230.87 (25.4%) stddev-sans-first:1197.03 06:12:33 INFO - PROCESS | 27872 | Values: 333.8 337.8 348.0 350.4 350.9 5055.3 5189.8 5237.7 5281.5 5296.8 4982.2 5084.7 5106.4 5109.1 5113.7 4059.3 4080.4 4084.4 4088.9 4092.8 3834.5 3849.2 4076.7 4094.7 4113.5 4047.3 4047.6 4057.7 4068.0 4078.8 4055.6 4073.8 4078.0 4086.0 4089.1 3672.3 3680.6 3681.9 3683.8 3688.2 4864.9 4966.8 4974.8 4976.6 5000.4 4646.0 4646.4 4656.9 4660.7 4666.6 5327.4 5338.2 5341.5 5342.7 5377.3 3851.3 3920.5 3948.6 3948.6 3961.8 5476.1 5511.3 5544.6 5547.4 5553.4 4069.5 4076.4 4089.0 4096.3 4109.8 3828.7 4012.4 4054.9 4144.3 4160.8 4533.9 4539.0 4582.7 4589.7 4596.7 5336.5 5341.8 5346.5 5389.3 5392.3 1261.3 1308.4 1327.7 1398.0 1414.4 890.3 899.3 916.7 919.6 919.8 4571.7 4573.6 4583.2 4599.9 4609.5 4814.9 4845.9 4868.2 4868.3 4891.9 4522.7 4546.6 4560.5 4566.2 4591.3 2400.7 2565.9 2571.1 2580.1 2601.3 4956.4 4965.5 4976.4 4996.7 5008.4 4683.5 4861.7 4880.6 4881.5 4902.4 4907.0 4954.2 4954.9 4964.5 4967.3 4781.6 4798.1 4831.3 4837.3 4849.8 4605.8 4759.8 4767.8 4773.9 4784.0 4853.6 4893.2 4918.4 4958.6 4973.9 3637.7 3643.6 3646.1 3646.3 3708.7 4869.7 4885.3 4907.0 4912.8 5321.7 4871.3 5293.7 5295.3 5328.8 5329.8 5317.3 5322.7 5346.8 5352.1 5441.2 5170.9 5255.8 5282.2 5365.3 5371.6 5372.8 5385.9 5387.2 5398.9 5401.6 5269.9 5280.7 5298.9 5328.2 5330.0 06:12:33 INFO - PROCESS | 27872 | 06:12:33 INFO - PROCESS | 27872 | [#5] yui.html Cycles:180 Average:20962.23 Median:54310.50 stddev:31132.27 (57.3%) stddev-sans-first:31182.53 06:12:33 INFO - PROCESS | 27872 | Values: 727.5 748.9 759.2 793.0 800.3 14681.3 16221.5 16276.6 16586.8 16620.8 15093.8 15337.5 15340.4 15353.3 15364.5 661.3 675.0 761.6 786.1 788.5 784.6 794.4 794.4 794.8 797.6 845.7 846.0 846.2 846.5 846.6 675.3 697.7 819.9 846.9 848.6 615.8 620.7 620.8 621.2 621.3 13499.0 13623.4 13654.4 13675.2 13787.8 14108.7 14340.5 14599.3 14609.2 14735.5 13104.4 13188.5 13195.8 13621.4 13709.8 4458.6 4545.8 4559.2 4739.5 4755.9 76037.0 77495.6 78058.6 78616.0 80363.2 11236.7 11391.8 11458.6 11770.7 11794.9 21995.6 22001.0 22003.7 22005.8 22006.0 7809.2 7844.6 7935.3 8479.5 8514.3 4406.3 4437.2 4456.0 4482.5 4572.4 3597.7 3698.8 3704.1 3706.8 3708.9 616.3 626.3 640.2 642.8 659.6 551.9 567.7 604.9 679.4 690.3 9002.8 9085.0 9170.7 9464.3 9600.0 546.7 563.3 568.5 571.8 616.1 4275.9 4540.8 4594.7 4646.6 4732.4 63764.0 74153.0 97778.5 123227.4 132444.0 106034.0 109561.5 110046.4 112410.4 116616.0 93408.5 94831.0 95734.0 96987.5 100145.0 8592.9 8757.0 8890.8 8915.4 9180.5 53074.5 53304.4 54199.0 54422.0 55415.7 74415.3 79210.0 82543.6 84333.6 86023.1 11276.9 11516.3 11677.5 11834.5 12032.0 12781.7 12825.4 12862.9 13015.3 13036.2 11396.1 11903.8 11917.0 11994.8 12394.3 11972.3 12069.5 12161.2 12580.9 12600.8 11295.9 11673.0 11741.5 12105.0 12132.9 8994.0 9214.6 9330.7 9378.8 9424.2 9127.5 9435.6 9644.4 9713.4 9798.0 06:12:33 INFO - PROCESS | 27872 | -------- Summary: end -------- 06:12:33 INFO - PROCESS | 27872 | 06:12:34 INFO - TEST-INFO | 27872: exit 0 06:12:34 INFO - TEST-OK | dromaeo_css | took 1118466ms 06:12:34 INFO - TEST-START | kraken 06:12:34 INFO - operating with platform_type : linux_ 06:12:34 INFO - Initialising browser for kraken test... 06:12:34 INFO - TEST-INFO | started process 28180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDaWRkU/profile http://localhost:36008/getInfo.html) 06:12:39 INFO - PROCESS | 28180 | __metrics Screen width/height:1600/1200 06:12:39 INFO - PROCESS | 28180 | colorDepth:24 06:12:39 INFO - PROCESS | 28180 | Browser inner width/height: 1024/697 06:12:39 INFO - PROCESS | 28180 | __metrics 06:12:40 INFO - PROCESS | 28180 | 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" 06:12:40 INFO - PROCESS | 28180 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:41 INFO - PROCESS | 28180 | console.error: PushService: 06:12:41 INFO - PROCESS | 28180 | stateChangeProcessEnqueue: Error transitioning state 06:12:41 INFO - PROCESS | 28180 | UnknownError 06:12:41 INFO - TEST-INFO | 28180: exit 0 06:12:41 INFO - Browser initialized. 06:12:41 INFO - Running cycle 1/1 for kraken test... 06:12:41 INFO - TEST-INFO | started process 28266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDaWRkU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:53 INFO - PROCESS | 28266 | RSS: Main: 178057216 06:12:53 INFO - PROCESS | 28266 | 06:12:56 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36008/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:57 INFO - PROCESS | 28266 | RSS: Main: 237649920 06:12:57 INFO - PROCESS | 28266 | 06:12:59 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36008/tests/kraken/driver.html?testName=audio-dft) 06:13:00 INFO - PROCESS | 28266 | RSS: Main: 221970432 06:13:00 INFO - PROCESS | 28266 | 06:13:03 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36008/tests/kraken/driver.html?testName=audio-fft) 06:13:04 INFO - PROCESS | 28266 | RSS: Main: 304156672 06:13:04 INFO - PROCESS | 28266 | 06:13:06 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36008/tests/kraken/driver.html?testName=audio-oscillator) 06:13:06 INFO - PROCESS | 28266 | RSS: Main: 213139456 06:13:06 INFO - PROCESS | 28266 | 06:13:09 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:09 INFO - PROCESS | 28266 | RSS: Main: 218181632 06:13:09 INFO - PROCESS | 28266 | 06:13:12 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36008/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:13 INFO - PROCESS | 28266 | RSS: Main: 254070784 06:13:13 INFO - PROCESS | 28266 | 06:13:16 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36008/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:17 INFO - PROCESS | 28266 | RSS: Main: 253452288 06:13:17 INFO - PROCESS | 28266 | 06:13:20 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36008/tests/kraken/driver.html?testName=json-parse-financial) 06:13:20 INFO - PROCESS | 28266 | RSS: Main: 253198336 06:13:20 INFO - PROCESS | 28266 | 06:13:22 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:22 INFO - PROCESS | 28266 | RSS: Main: 215212032 06:13:22 INFO - PROCESS | 28266 | 06:13:24 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:25 INFO - PROCESS | 28266 | RSS: Main: 221855744 06:13:25 INFO - PROCESS | 28266 | 06:13:27 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:27 INFO - PROCESS | 28266 | RSS: Main: 227352576 06:13:27 INFO - PROCESS | 28266 | 06:13:30 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:31 INFO - PROCESS | 28266 | RSS: Main: 237088768 06:13:31 INFO - PROCESS | 28266 | 06:13:33 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:34 INFO - PROCESS | 28266 | RSS: Main: 234627072 06:13:34 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | Cycle 1(1): loaded http://localhost:36008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36008/tests/kraken/driver.html?testName=ai-astar) 06:13:36 INFO - PROCESS | 28266 | RSS: Main: 284303360 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | __start_tp_report 06:13:36 INFO - PROCESS | 28266 | _x_x_mozilla_page_load 06:13:36 INFO - PROCESS | 28266 | _x_x_mozilla_page_load_details 06:13:36 INFO - PROCESS | 28266 | |i|pagename|runs| 06:13:36 INFO - PROCESS | 28266 | |0;ai-astar;111;112;112;112;116;112;113;115;112;111 06:13:36 INFO - PROCESS | 28266 | |1;audio-beat-detection;154;122;120;149;122;123;121;121;156;122 06:13:36 INFO - PROCESS | 28266 | |2;audio-dft;161;160;161;161;160;159;162;161;161;161 06:13:36 INFO - PROCESS | 28266 | |3;audio-fft;75;75;76;117;76;76;78;77;97;76 06:13:36 INFO - PROCESS | 28266 | |4;audio-oscillator;82;83;107;84;82;83;105;83;91;119 06:13:36 INFO - PROCESS | 28266 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:13:36 INFO - PROCESS | 28266 | |6;imaging-darkroom;147;147;146;146;146;145;145;146;145;145 06:13:36 INFO - PROCESS | 28266 | |7;imaging-desaturate;95;96;96;96;96;97;96;96;96;96 06:13:36 INFO - PROCESS | 28266 | |8;json-parse-financial;54;51;52;51;52;52;53;53;53;52 06:13:36 INFO - PROCESS | 28266 | |9;json-stringify-tinderbox;61;62;61;61;62;61;62;61;61;61 06:13:36 INFO - PROCESS | 28266 | |10;stanford-crypto-aes;79;80;80;80;80;80;79;84;80;79 06:13:36 INFO - PROCESS | 28266 | |11;stanford-crypto-ccm;140;133;132;137;138;144;133;131;171;130 06:13:36 INFO - PROCESS | 28266 | |12;stanford-crypto-pbkdf2;166;163;165;168;165;170;164;166;165;166 06:13:36 INFO - PROCESS | 28266 | |13;stanford-crypto-sha256-iterative;68;70;65;66;68;65;65;65;65;64 06:13:36 INFO - PROCESS | 28266 | __end_tp_report 06:13:36 INFO - PROCESS | 28266 | __start_cc_report 06:13:36 INFO - PROCESS | 28266 | _x_x_mozilla_cycle_collect,1643 06:13:36 INFO - PROCESS | 28266 | __end_cc_report 06:13:36 INFO - PROCESS | 28266 | __startTimestamp1475586816411__endTimestamp 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | ------- Summary: start ------- 06:13:36 INFO - PROCESS | 28266 | Number of tests: 14 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:1.65 (1.5%) stddev-sans-first:1.64 06:13:36 INFO - PROCESS | 28266 | Values: 111.0 112.0 112.0 112.0 116.0 112.0 113.0 115.0 112.0 111.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:122.50 stddev:15.30 (12.5%) stddev-sans-first:13.78 06:13:36 INFO - PROCESS | 28266 | Values: 154.0 122.0 120.0 149.0 122.0 123.0 121.0 121.0 156.0 122.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 06:13:36 INFO - PROCESS | 28266 | Values: 161.0 160.0 161.0 161.0 160.0 159.0 162.0 161.0 161.0 161.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.87 (18.3%) stddev-sans-first:14.46 06:13:36 INFO - PROCESS | 28266 | Values: 75.0 75.0 76.0 117.0 76.0 76.0 78.0 77.0 97.0 76.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.00 stddev:13.46 (16.2%) stddev-sans-first:13.79 06:13:36 INFO - PROCESS | 28266 | Values: 82.0 83.0 107.0 84.0 82.0 83.0 105.0 83.0 91.0 119.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:13:36 INFO - PROCESS | 28266 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 06:13:36 INFO - PROCESS | 28266 | Values: 147.0 147.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 06:13:36 INFO - PROCESS | 28266 | Values: 95.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.78 06:13:36 INFO - PROCESS | 28266 | Values: 54.0 51.0 52.0 51.0 52.0 52.0 53.0 53.0 53.0 52.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 06:13:36 INFO - PROCESS | 28266 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 62.0 61.0 61.0 61.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:1.45 (1.8%) stddev-sans-first:1.48 06:13:36 INFO - PROCESS | 28266 | Values: 79.0 80.0 80.0 80.0 80.0 80.0 79.0 84.0 80.0 79.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:137.50 stddev:12.11 (8.8%) stddev-sans-first:12.84 06:13:36 INFO - PROCESS | 28266 | Values: 140.0 133.0 132.0 137.0 138.0 144.0 133.0 131.0 171.0 130.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:1.99 (1.2%) stddev-sans-first:2.11 06:13:36 INFO - PROCESS | 28266 | Values: 166.0 163.0 165.0 168.0 165.0 170.0 164.0 166.0 165.0 166.0 06:13:36 INFO - PROCESS | 28266 | 06:13:36 INFO - PROCESS | 28266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:65.50 stddev:1.91 (2.9%) stddev-sans-first:1.90 06:13:36 INFO - PROCESS | 28266 | Values: 68.0 70.0 65.0 66.0 68.0 65.0 65.0 65.0 65.0 64.0 06:13:36 INFO - PROCESS | 28266 | -------- Summary: end -------- 06:13:36 INFO - PROCESS | 28266 | 06:13:37 INFO - TEST-INFO | 28266: exit 0 06:13:37 INFO - TEST-OK | kraken | took 62721ms 06:13:37 INFO - SUITE-END | took 1181s 06:13:38 INFO - Completed test suite (00:19:41) 06:13:38 INFO - javascript benchmark 06:13:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2980.2251414632196, 3000.594919685842, 3005.459017376872, 3035.453618348699, 3051.3897220555896, 5130.769115389807, 5186.7147306898105, 5202.4277329493725, 5211.5309622134, 5275.894482110355, 5264.6051546134, 5287.524122828935, 5296.841094767163, 5351.678899266037, 5418.783248670048, 4748.240281554952, 4797.0645724083815, 4812.807487700487, 4824.951750482503, 4833.806647734086, 4886.36477257956, 4923.679960802554, 4926.507349265081, 4929.778159982791, 4950.529699678543, 4606.585407313358, 4664.836730714443, 4669.743164125972, 4838.29844672524, 4884.267359896026, 4779.0, 4796.880077998043, 4809.639277054235, 4816.422029356465, 4842.782074806642, 4771.5467030632035, 4774.80900763969, 4778.928316075262, 4786.186348320759, 4838.637102217348, 5041.798328066873, 5074.086664400406, 5287.365516138049, 5289.391719952217, 5344.198370244456, 5506.476884695988, 5597.44025597437, 5600.131979543136, 5703.942960570383, 5708.229389032469, 5661.575381846378, 5672.68800215988, 5676.971615141898, 5735.885282294331, 5739.62692424991, 5225.764840582183, 5261.894762104736, 5273.947260527384, 5278.076336641073, 5310.097283461821, 5521.3926468088475, 5528.889422211533, 5738.512226460798, 5762.2221000164445, 5790.160426738099, 5562.415946325658, 5568.387477377485, 5606.971965140148, 5675.1487276907965, 5676.574256930747, 5677.630953987978, 5683.0, 5685.0, 5685.971570142206, 5709.25779648643, 5399.70301633414, 5501.284832971768, 5660.858478537987, 5663.093904975184, 5666.744996475169, 5473.0969390051, 5527.723613819293, 5547.5007249347755, 5578.581606379456, 5640.041192997201, 4321.805518751664, 4328.870133895925, 4336.241157797436, 4376.474823021258, 4380.014496738272, 3809.066778639251, 3845.0964023454467, 3858.8456461741216, 3863.6522712955407, 3902.414637804352, 5183.533481986639, 5280.155175171954, 5290.15357542799, 5361.115415956401, 5393.43368946255, 5733.082706766897, 5736.741846616912, 5742.598018138774, 5743.655380677173, 5764.682942438206, 5367.677939323653, 5387.595930305243, 5406.540444062299, 5413.106837371868, 5414.35027796667, 4737.715737055788, 4741.502142275081, 4817.397825271841, 4882.12121818069, 4960.330355402047, 5889.764409423747, 5896.262967129109, 5900.527957763283, 5932.673702946293, 5944.64332140073, 5708.286464191976, 5708.743106560131, 5715.5713321500225, 5721.7425215866215, 5726.940516004553, 5606.074997625346, 5643.548516118783, 5822.592418530662, 5848.093545500455, 5849.268841394825, 5568.303962004749, 5609.943900561106, 5613.354464236501, 5655.519280861173, 5675.914861277167, 5659.745311460912, 5723.255976723, 5729.942700572941, 5731.168980497721, 5732.283464566929, 5314.362276526842, 5381.623286369917, 5501.862453438536, 5576.749046292845, 5579.0, 5400.054990376747, 5470.370907345547, 5472.042392581362, 5496.120620700669, 5537.723113844372, 5414.0, 5415.566754659697, 5423.945760542344, 5430.511253987002, 5431.891362172813, 5336.0, 5504.119340905436, 5504.862378440571, 5517.613767036269, 5550.666959982414, 5272.446393128666, 5324.520793128637, 5369.167778994262, 5385.730713464232, 5450.2369668247275], "value": 5198.886472514276, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.8228460793805, 583.3204316970729, 602.6655206360474, 603.9642013946079, 613.6870196199939, 32009.0, 32740.0, 34967.475487867705, 34973.82513087434, 43651.56348436515, 42134.0, 46059.76970115145, 46217.0, 46268.53731462693, 46289.30566041503, 8867.645294188225, 9010.369274150811, 9024.819503609924, 9027.14242146995, 9036.412633178823, 8852.778680532974, 8923.598438070303, 8931.64273429062, 8935.55322233889, 8952.194302512773, 8954.910450895506, 9017.0, 9018.86471702925, 9020.503872287021, 9021.503817290046, 8905.287576993858, 8945.59744811485, 8951.373403861733, 8951.41815781972, 8958.283337332998, 8924.393609150351, 8991.955040224822, 8995.370324077317, 8999.325050621164, 9002.909970900273, 41200.587994119975, 41562.37656435156, 41588.79205603953, 41631.0, 41676.0, 3371.645977172386, 3663.157473781045, 3917.882463526099, 4088.9795551022053, 4155.792210389499, 30691.925782597504, 31867.52198717021, 31880.0, 32022.679773202202, 32163.19592010195, 4266.338717498793, 4364.301711726109, 4378.1462614790125, 4569.497355290915, 4579.5878370946775, 325492.0, 327287.0, 327674.0, 328815.0, 329073.0, 56333.43666563364, 56501.7174914131, 56669.71665141648, 56705.14942275869, 56711.14933276004, 60416.0, 60498.0, 60599.0, 60621.0, 60710.0, 16206.0, 16211.27049282785, 16467.670646587, 16469.91765041191, 16474.58813529671, 11801.29192248468, 11827.397972446048, 11830.881691182978, 11831.230969986924, 11854.703632409259, 15534.844651553565, 16352.0, 16448.917755411145, 16556.337746490248, 16698.0, 5003.346218772764, 5633.267675202197, 5720.48515633595, 5738.885222295614, 5920.407959204132, 943.9292053095908, 945.7257395355269, 975.7560609847538, 983.090641156927, 1039.1686650679426, 30837.0, 30891.691083089332, 30923.536146957813, 31548.36903261922, 31766.682333176836, 1015.3298822776932, 1021.6015753856002, 1067.5783065689166, 1147.391882302381, 1167.9357635329968, 15032.473863414729, 15955.920220398824, 15959.281832317574, 15962.36150553988, 16230.269637866324, 486653.0, 488421.0, 489697.0, 489910.0, 490395.0, 55245.0, 55313.72343138339, 55395.0, 55514.72242638761, 55577.72211138919, 1228.993855030737, 1254.2223821230714, 1310.0829419406264, 1342.6039318401095, 1353.1069494133824, 28437.43125137527, 30044.849775751856, 30345.848270758506, 30579.0, 31103.533446998765, 47897.76051119861, 48228.0, 48380.0, 48417.75791121022, 48430.757846210545, 385172.0, 385991.0, 386688.0, 386845.0, 388102.0, 26916.596251056642, 27265.591016134378, 27621.30946726348, 27673.308167295978, 28713.0, 46075.0, 46105.07789844251, 46128.0, 46150.30774538317, 46769.0, 38268.0, 39143.41284880786, 39783.0, 40163.39754903737, 41146.794266028475, 38412.61587384091, 38560.42159367556, 39119.608803912735, 39886.60113398829, 40959.38560921648, 38769.80615096907, 39648.40527392034, 39999.400008999306, 40226.59773402228, 40452.1909561813, 30551.0, 34223.48664769981, 35074.473882892285, 37617.0, 38675.0, 27141.457170856866, 27685.0, 27851.58222626622, 27976.06251343661, 27978.44043119167], "value": 19324.949449004696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.6829200055955, 404.59944654791764, 408.6220246272198, 410.8870060733298, 426.1285670803207, 13263.602091937246, 15350.462733804305, 18872.0, 19332.0, 19675.60648787027, 18712.345067922626, 18830.15264313106, 19164.520886977796, 19167.616647667037, 19176.137073831676, 5096.949030509703, 5717.714114294289, 5801.941980580204, 6055.9697201514155, 6056.909146362808, 5901.645901245939, 5939.1388248703915, 5995.460408563228, 5997.6701281429505, 6000.33996260411, 5730.4269573042575, 5811.912821307684, 5832.737526811283, 5960.135780311853, 5966.478547970261, 5840.065589505659, 5861.413858614147, 5909.497692696126, 5914.319853216892, 5916.97041514794, 5154.742262886841, 5318.707471089088, 5451.209574611698, 5510.614257002011, 5577.69322687252, 13952.511662091778, 14007.229602371866, 14194.787078193835, 21233.071881701933, 21948.670769938464, 2150.2044243629803, 2266.240809328877, 2272.749997500274, 2524.1587382193525, 2599.233226198276, 10134.13859821916, 10541.420221887793, 10724.731881702943, 12325.5069797208, 13563.796543051862, 1853.4347024157626, 1933.5166208447888, 1945.3815902421484, 1967.1541237267968, 1989.263972330247, 78786.21213787847, 78980.60509697472, 79043.0, 79897.60051199707, 80992.59503702502, 10931.781364372668, 11052.778944421067, 11184.161187910777, 11259.437028148559, 11371.849275014725, 15401.691966160613, 15498.0, 16023.839761602469, 16211.189440528162, 16220.270087846075, 6480.481561475165, 6616.768413105518, 7657.387409007266, 7848.646810893523, 8393.874091888505, 7231.963840180765, 7621.199774023758, 7628.923710762932, 7816.921830781733, 7900.9604951976025, 4797.376341075638, 4880.267959806058, 4881.926771098437, 4950.3069570260195, 4967.428745694219, 1961.3723608445162, 1989.532459871929, 2026.1692705990474, 2057.722207501998, 2075.1803037800287, 853.8804567360575, 932.3100905330007, 991.7421470417744, 1009.8636684047707, 1075.774087441646, 18208.998505082083, 19272.518187045436, 19358.128884200243, 19391.576052993376, 19890.30383936555, 936.9859452108224, 960.3037797596826, 988.5551501824208, 990.7968866382519, 999.2655398282257, 9675.758106047406, 10694.580005178997, 10724.41015744126, 10733.302335348177, 10775.976282253174, 401251.0, 405003.0, 406711.0, 411019.0, 412942.0, 54527.0, 66461.6676916622, 84447.57776211202, 85529.0, 87796.12203878007, 951.6383774165772, 954.8615450759601, 992.6079198716467, 993.1973468155275, 994.4381424495137, 17034.101189018467, 17649.117544123, 18093.562223177552, 18127.27490900402, 18261.452156435327, 37179.6282037187, 41425.0, 41615.7919210402, 41662.58337416708, 42728.78635606802, 46698.0, 56642.433575663716, 56960.71519642375, 57273.0, 57722.711386442796, 7969.521828690297, 8078.394120441108, 8313.584320784057, 8380.329573633973, 8660.956695216484, 11560.768784624091, 12615.93692031534, 12661.987041036511, 12677.30274834856, 12709.745805084032, 9940.801183976424, 10506.579736810747, 10860.728481788019, 10894.202456594574, 11128.666140015812, 11076.501557429774, 11391.316521008766, 11465.598704045318, 11509.597164099216, 11567.710807229887, 11142.387168705798, 11194.160437967023, 11208.383538905438, 11211.495482703462, 11642.592509262135, 8159.061707903667, 8223.21879421454, 8381.11998240176, 8552.828943421222, 8822.86765698528, 8666.826663466569, 10085.747856303651, 10368.326058806153, 10399.307972239141, 10447.05976462122], "value": 8927.326385218248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.4141956829214, 1383.3429121167446, 1456.3228098933996, 1498.527963691438, 1738.756574079629, 7695.730649427272, 8680.8697869532, 9040.54797260136, 9045.09549045095, 9318.114779095975, 9082.95458522708, 9163.312751543628, 9169.77075573111, 9173.403728757627, 9173.449593024423, 2358.8938497767554, 2378.9286321410386, 2382.7498112698177, 2386.081358676913, 2388.2118900762794, 2324.6164382876805, 2367.3253122859987, 2381.738008819037, 2382.4520360317138, 2386.152915714922, 2382.3805810489225, 2384.3562238195677, 2386.7016622922133, 2433.7201221859536, 2439.231642032763, 2335.089315167086, 2340.2394221877958, 2349.1073392110975, 2351.447409858682, 2375.406148462884, 2323.070771691337, 2335.0309621507054, 2344.753800850903, 2346.9530609387716, 2351.564960482316, 8957.462552246887, 8979.102089791035, 9013.594388252544, 9029.63881444748, 9109.726708198765, 5188.584913206934, 5203.583713302926, 5365.704886231256, 5366.356037275552, 5367.973160134214, 3367.545381373532, 3468.4103702370403, 3546.29074185164, 3557.1107223194203, 3577.409727394977, 1111.6776134920863, 1144.210494758614, 1194.546072492456, 1218.0499210615646, 1234.0559472003924, 12202.779722027815, 12224.816627750592, 12246.571370002008, 12268.570600029045, 12271.754564908651, 4472.955270447319, 4527.139843429738, 4652.0, 4672.556107169813, 4764.595009424238, 9657.082577155159, 9677.516124193762, 9697.272704547187, 9701.175400091071, 9704.563294651616, 5206.739663016834, 5231.346081739783, 5238.6594871334, 5244.816431424958, 5245.160774276097, 4223.5142958559545, 4349.282368409177, 4807.759612019385, 4894.412670479565, 4926.507349265116, 3772.981135094362, 3773.471713960048, 3843.55799083109, 3905.804709764557, 3911.3155197840265, 1184.1829137894824, 1186.928784272929, 1195.0081432411077, 1205.4274219745726, 1208.4682739594725, 839.7900524868783, 841.6885752271576, 847.6778824046822, 884.4339622641514, 905.1175104273412, 5311.548518375904, 5501.301921884687, 5548.55611551075, 5633.718314084279, 5644.8871022579315, 424.91501699659574, 428.8499025341168, 439.6175327465062, 439.82846689791006, 454.3525476196407, 3769.6984241260634, 3821.770693758328, 3856.2094770571966, 3860.9806950965067, 3892.380086519564, 10719.303245289031, 11366.204365694322, 11436.94281528587, 11466.827997580043, 11471.082313414907, 11120.110391168688, 11393.202475826778, 11423.942880285711, 11429.314241145392, 11434.485448154854, 8400.579971001425, 8496.915030849736, 8518.659253629785, 8545.48727076365, 8545.487270763773, 5395.190721391823, 5427.48438898304, 5526.530244929226, 5539.14143307788, 5672.971635141798, 10302.536385862504, 10424.739381515219, 10446.164306855586, 10478.161747060369, 10595.09941654968, 10351.223658225512, 10539.209559282932, 10741.785164296827, 10949.726256843323, 10951.780964380509, 6552.541322107407, 6773.254941956282, 7252.528585641917, 7738.651760670896, 7811.414143939113, 8379.413441059067, 8813.42712723671, 8820.603072861864, 8827.911720882708, 8830.558472076498, 7767.883481747665, 7801.1808760079375, 7883.6846526138315, 7933.722319718782, 8056.154103819014, 7456.47804653669, 7577.696892124253, 7582.241775822374, 7587.355074818703, 7711.8072048197, 6595.505337099833, 6709.93290067093, 6711.697973591103, 6719.0, 6721.092652491851, 4568.657350698777, 4697.577218050392, 4722.197226471577, 4740.834070807505, 4791.089692958327, 4553.681242313006, 4601.976990115028, 4625.375574297427, 4694.0, 4895.4370247422], "value": 4497.343566408101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.77704488109197, 337.84627994262615, 347.9860805567777, 350.3973166154214, 350.8824543777836, 5055.266986286986, 5189.8183563575285, 5237.685738855666, 5281.471852814717, 5296.841094767158, 4982.153033984222, 5084.720340381286, 5106.387233531981, 5109.131447653898, 5113.693178409298, 4059.320848240162, 4080.367543030835, 4084.4077608746716, 4088.8568900088503, 4092.815823287959, 3834.482344883447, 3849.191669749356, 4076.694247931402, 4094.6724262058965, 4113.4858142732155, 4047.311956967308, 4047.5750046245016, 4057.6753859691303, 4067.9796601016956, 4078.775667338295, 4055.614716601918, 4073.775942323171, 4077.9592204077876, 4085.9591404085877, 4089.1208390196102, 3672.3022625701296, 3680.5583330000572, 3681.871134510306, 3683.7605555639066, 3688.17016171362, 4864.902701945976, 4966.826161084345, 4974.801007959677, 4976.62675299354, 5000.42495113063, 4645.953540464586, 4646.372739680134, 4656.930146047812, 4660.650451216138, 4666.5533684557895, 5327.440618735054, 5338.199270109515, 5341.4658534146665, 5342.679439233659, 5377.3009508764, 3851.287511810296, 3920.5491368492417, 3948.605139486057, 3948.605139486057, 3961.8217180226957, 5476.096444086721, 5511.338639363262, 5544.584156188343, 5547.417521160301, 5553.416891226403, 4069.491313585802, 4076.408920706481, 4088.9795551022053, 4096.3036283831225, 4109.835606575703, 3828.693704503633, 4012.398140278923, 4054.8580799671868, 4144.295469770146, 4160.793369922749, 4533.886652833706, 4538.977305113453, 4582.725036497821, 4589.737822098883, 4596.724196548218, 5336.519713225751, 5341.786328546815, 5346.492083252085, 5389.272448219519, 5392.325959255093, 1261.2621616354352, 1308.378520202896, 1327.674719693662, 1397.986020139806, 1414.4130185972706, 890.3055616619048, 899.321012635456, 916.6883259691604, 919.6459363145237, 919.7516670498928, 4571.748553829505, 4573.565511276423, 4583.166733306704, 4599.862004139881, 4609.539046095364, 4814.855554333306, 4845.878853028703, 4868.2210846264425, 4868.269759536027, 4891.877703057452, 4522.66080043998, 4546.636269098464, 4560.498345182027, 4566.246569316092, 4591.288350305708, 2400.663907053014, 2565.9486810264066, 2571.0744132112422, 2580.109862097573, 2601.270155346711, 4956.397891107125, 4965.503449655005, 4976.377952755905, 4996.650234483552, 5008.424031236382, 4683.531646835358, 4861.70829750209, 4880.6095512358925, 4881.536254055859, 4902.362692849907, 4907.0, 4954.234781566108, 4954.851354459372, 4964.453910069889, 4967.279744437109, 4781.641376896816, 4798.136335459651, 4831.323614693875, 4837.250226214942, 4849.781759820887, 4605.769711514478, 4759.76201189946, 4767.809287628456, 4773.880652983703, 4783.976080119577, 4853.587445067209, 4893.168161412497, 4918.43438004634, 4958.6281028923695, 4973.900521989613, 3637.672609465161, 3643.635636436335, 3646.106703857572, 3646.3254297954963, 3708.6847617952776, 4869.732164730974, 4885.338984745204, 4906.95093049065, 4912.803487860446, 5321.6540924839765, 4871.269309603588, 5293.7353132344, 5295.311609490742, 5328.813491527778, 5329.840104796862, 5317.282166907418, 5322.707251101227, 5346.8395948121615, 5352.090144675337, 5441.238226648352, 5170.870728231825, 5255.78976840922, 5282.207668849704, 5365.302510673588, 5371.5702743781185, 5372.811951581833, 5385.919211211756, 5387.245785590099, 5398.892022159614, 5401.594880383908, 5269.868253293698, 5280.7326241702485, 5298.920516192183, 5328.17413300939, 5330.0], "value": 3956.893587142248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.4689476682021, 748.8652042632327, 759.199045007517, 792.9563873986929, 800.3077338102543, 14681.265936703163, 16221.513354599381, 16276.593085172877, 16586.83413165868, 16620.750688739678, 15093.773593396081, 15337.539873803777, 15340.386384544632, 15353.30910109045, 15364.539063828102, 661.3155384177377, 674.9628770417625, 761.603965937712, 786.1116937860224, 788.4874831359605, 784.6469088909985, 794.3962588432775, 794.408165916393, 794.7854079398559, 797.5812698333364, 845.7293666026874, 846.022843615625, 846.1665259719172, 846.5259454705384, 846.5682501924032, 675.2841987493273, 697.6860412814253, 819.8852160697447, 846.9280111190557, 848.5969164646805, 615.7660089166133, 620.7051650466037, 620.8106527509108, 621.2079598511888, 621.3134486392516, 13499.0, 13623.386947587382, 13654.385552650154, 13675.247861367621, 13787.793183102161, 14108.672069108585, 14340.498082567061, 14599.343029563695, 14609.196494192814, 14735.484258050918, 13104.410301536454, 13188.538401156009, 13195.767037075882, 13621.387037583332, 13709.794353084711, 4458.554144585515, 4545.795439205243, 4559.156556037144, 4739.549742774431, 4755.857324280277, 76037.0, 77495.6125219376, 78058.60970695167, 78616.0, 80363.19636803615, 11236.719082022852, 11391.772164556829, 11458.59894903691, 11770.705732356588, 11794.941025294818, 21995.560088798135, 22001.0, 22003.669944950838, 22005.779942200694, 22006.0, 7809.180036096242, 7844.607769611611, 7935.285824275843, 8479.491230526064, 8514.276286515591, 4406.272964960745, 4437.2234858899565, 4456.0, 4482.5069242383315, 4572.4055872736335, 3597.730170237243, 3698.8335524901445, 3704.0554658561896, 3706.8331925063435, 3708.9072773180887, 616.3066550131102, 626.2985456288985, 640.2093414632925, 642.8264368620446, 659.591053546804, 551.8620344913771, 567.730328094152, 604.8699529601157, 679.4089142446104, 690.3441730356082, 9002.774930626787, 9084.954575227082, 9170.67902623405, 9464.337496375325, 9600.039996000343, 546.6638017619135, 563.2818156849967, 568.46848196936, 571.8227349521661, 616.140484024783, 4275.850345237964, 4540.84107056258, 4594.678372513892, 4646.628269738413, 4732.408448943882, 63764.0, 74153.0, 97778.511107444, 123227.3838630801, 132444.0, 106034.0, 109561.45219273852, 110046.44976775064, 112410.43794780974, 116616.0, 93408.53295733478, 94831.0, 95734.0, 96987.51506242424, 100145.0, 8592.914070859462, 8756.956215218883, 8890.822183556422, 8915.375923685539, 9180.495072770795, 53074.4692553085, 53304.4052070631, 54199.0, 54422.0, 55415.72292138513, 74415.25584744083, 79210.0, 82543.5872820632, 84333.57833210795, 86023.13976860151, 11276.94361528187, 11516.30902145874, 11677.532898683958, 11834.526618935146, 12032.037437004843, 12781.680457988625, 12825.43545145823, 12862.935685321514, 13015.349232538147, 13036.217826930415, 11396.110858972464, 11903.821442678194, 11917.046636269251, 11994.76010479803, 12394.256344619353, 11972.281663100242, 12069.456874440846, 12161.209521381083, 12580.87419125797, 12600.810987835373, 11295.866418259773, 11673.0, 11741.530338786353, 12105.0, 12132.939335303266, 8994.0, 9214.631414743335, 9330.673426430314, 9378.812423751624, 9424.198943089914, 9127.543622818699, 9435.57539910692, 9644.421334719938, 9713.36863103896, 9797.951010244904], "value": 7317.442806496038, "unit": "score"}], "name": "dromaeo_css", "value": 6991.621636598742, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 112.0, 116.0, 112.0, 113.0, 115.0, 112.0, 111.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 120.0, 149.0, 122.0, 123.0, 121.0, 121.0, 156.0, 122.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 160.0, 159.0, 162.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 117.0, 76.0, 76.0, 78.0, 77.0, 97.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 107.0, 84.0, 82.0, 83.0, 105.0, 83.0, 91.0, 119.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 51.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 80.0, 80.0, 79.0, 84.0, 80.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 132.0, 137.0, 138.0, 144.0, 133.0, 131.0, 171.0, 130.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 165.0, 168.0, 165.0, 170.0, 164.0, 166.0, 165.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 65.0, 66.0, 68.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1501.7999999999997, "alertThreshold": 2.0}]} 06:13:38 INFO - Return code: 0 06:13:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:38 INFO - # TBPL SUCCESS # 06:13:38 INFO - Running post-action listener: _resource_record_post_action 06:13:38 INFO - [mozharness: 2016-10-04 13:13:38.233536Z] Finished run-tests step (success) 06:13:38 INFO - Running post-run listener: _resource_record_post_run 06:13:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395546624; Read time: 4; Write time: 451780 06:13:38 INFO - TinderboxPrint: CPU usage
13.1% 06:13:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:13:38 INFO - TinderboxPrint: I/O write bytes / time
395,546,624 / 451,780 06:13:38 INFO - TinderboxPrint: CPU idle
8,309.0 (86.9%) 06:13:38 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 06:13:38 INFO - TinderboxPrint: Swap in / out
0 / 0 06:13:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104517632; Read time: 0; Write time: 124348 06:13:38 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 291028992; Read time: 0; Write time: 327432 06:13:38 INFO - Running post-run listener: _upload_blobber_files 06:13:38 INFO - Blob upload gear active. 06:13:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:38 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 06:13:38 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:13:38 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:13:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:42 INFO - (blobuploader) - INFO - Done attempting. 06:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:43 INFO - (blobuploader) - INFO - Done attempting. 06:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:43 INFO - (blobuploader) - INFO - Done attempting. 06:13:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:43 INFO - Return code: 0 06:13:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d98ffe72bdd699b4b9f44987df2765ed4231eafbe5a0d7d3f5d4980caa2e30395d1621f5eb7538161d593c68c031d1a77a8f4e027584a9db4b218ed1b8741ecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4e99a71c993d26de1b5a8ebb2aff57fb061ace0896c511616bdc5e10c528310b308d4b951adb7dd264b9151f640801bb0c76e6f5684d7e2d1ad1c116848300c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78377c0abce723044a5f27d70edf96608c5c59943a003e474ad4a3f135272902c70eb67f802e105dadb95741a1c4369a8612894ffdaab29e97791ab1f6e596c9"} 06:13:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:43 INFO - Contents: 06:13:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d98ffe72bdd699b4b9f44987df2765ed4231eafbe5a0d7d3f5d4980caa2e30395d1621f5eb7538161d593c68c031d1a77a8f4e027584a9db4b218ed1b8741ecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4e99a71c993d26de1b5a8ebb2aff57fb061ace0896c511616bdc5e10c528310b308d4b951adb7dd264b9151f640801bb0c76e6f5684d7e2d1ad1c116848300c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78377c0abce723044a5f27d70edf96608c5c59943a003e474ad4a3f135272902c70eb67f802e105dadb95741a1c4369a8612894ffdaab29e97791ab1f6e596c9"} 06:13:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:43 INFO - Copying logs to upload dir... 06:13:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.981040 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-04 06:13:43.630626) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 06:13:43.634662) ========= 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=df17445c3590ff7897617a0e00000225-1475584707.264093-877291153 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/sha512/d98ffe72bdd699b4b9f44987df2765ed4231eafbe5a0d7d3f5d4980caa2e30395d1621f5eb7538161d593c68c031d1a77a8f4e027584a9db4b218ed1b8741ecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4e99a71c993d26de1b5a8ebb2aff57fb061ace0896c511616bdc5e10c528310b308d4b951adb7dd264b9151f640801bb0c76e6f5684d7e2d1ad1c116848300c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78377c0abce723044a5f27d70edf96608c5c59943a003e474ad4a3f135272902c70eb67f802e105dadb95741a1c4369a8612894ffdaab29e97791ab1f6e596c9"} build_url:https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/SVbSNn3jRSuUAsX_uap2XA/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/sha512/d98ffe72bdd699b4b9f44987df2765ed4231eafbe5a0d7d3f5d4980caa2e30395d1621f5eb7538161d593c68c031d1a77a8f4e027584a9db4b218ed1b8741ecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4e99a71c993d26de1b5a8ebb2aff57fb061ace0896c511616bdc5e10c528310b308d4b951adb7dd264b9151f640801bb0c76e6f5684d7e2d1ad1c116848300c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78377c0abce723044a5f27d70edf96608c5c59943a003e474ad4a3f135272902c70eb67f802e105dadb95741a1c4369a8612894ffdaab29e97791ab1f6e596c9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 06:13:43.660041) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:13:43.660393) ========= 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=df17445c3590ff7897617a0e00000225-1475584707.264093-877291153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:13:43.746296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 06:13:43.746656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 06:13:43.746951) ========= ========= Total master_lag: 0.18 =========