builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1478610450.37 results: success (0) buildid: 20161108030212 builduid: 5f4e42c5c6fb4ba2822ef60cdb11a2b3 revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.367310) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.367865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.368170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.382514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.382826) ========= 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=826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 05:07:30-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.2K=0.2s 2016-11-08 05:07:30 (58.2 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.319168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.716258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.716621) ========= 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=826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014153 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.766139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:30.766527) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f13e90d496cf1bc6dfc4fd398da33e4afe785bde --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 f13e90d496cf1bc6dfc4fd398da33e4afe785bde --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=826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 05:07:30,989 truncating revision to first 12 chars 2016-11-08 05:07:30,989 Setting DEBUG logging. 2016-11-08 05:07:30,989 attempt 1/10 2016-11-08 05:07:30,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f13e90d496cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 05:07:31,298 unpacking tar archive at: mozilla-central-f13e90d496cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:31.413421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:31.413808) ========= script_repo_revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:31.414286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:31.414568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 05:07:31.423144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-08 05:07:31.423433) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:31 INFO - MultiFileLogger online at 20161108 05:07:31 in /builds/slave/test 05:07:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:07:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:31 INFO - {'append_to_log': False, 05:07:31 INFO - 'base_work_dir': '/builds/slave/test', 05:07:31 INFO - 'blob_upload_branch': 'Firefox', 05:07:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:31 INFO - 'branch': 'Firefox', 05:07:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:31 INFO - 'config_files': ('talos/linux_config.py',), 05:07:31 INFO - 'default_actions': ('clobber', 05:07:31 INFO - 'read-buildbot-config', 05:07:31 INFO - 'download-and-extract', 05:07:31 INFO - 'populate-webroot', 05:07:31 INFO - 'create-virtualenv', 05:07:31 INFO - 'install', 05:07:31 INFO - 'run-tests'), 05:07:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:31 INFO - 'download_minidump_stackwalk': True, 05:07:31 INFO - 'download_symbols': 'ondemand', 05:07:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:31 INFO - 'installer_path': 'installer.exe', 05:07:31 INFO - 'log_level': 'info', 05:07:31 INFO - 'log_name': 'talos', 05:07:31 INFO - 'log_to_console': True, 05:07:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:31 INFO - 'opt_config_files': (), 05:07:31 INFO - 'pip_index': False, 05:07:31 INFO - 'sps_profile': False, 05:07:31 INFO - 'sps_profile_interval': 0, 05:07:31 INFO - 'suite': 'dromaeojs-e10s', 05:07:31 INFO - 'system_bits': '32', 05:07:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:31 INFO - 'title': 'talos-linux64-ix-052', 05:07:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:31 INFO - 'use_talos_json': True, 05:07:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:31 INFO - 'work_dir': 'build'} 05:07:31 INFO - [mozharness: 2016-11-08 13:07:31.739508Z] Running clobber step. 05:07:31 INFO - Running pre-action listener: _resource_record_pre_action 05:07:31 INFO - Running main action method: clobber 05:07:31 INFO - rmtree: /builds/slave/test/build 05:07:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:32 INFO - Running post-action listener: _resource_record_post_action 05:07:32 INFO - [mozharness: 2016-11-08 13:07:32.196526Z] Finished clobber step (success) 05:07:32 INFO - [mozharness: 2016-11-08 13:07:32.196625Z] Running read-buildbot-config step. 05:07:32 INFO - Running pre-action listener: _resource_record_pre_action 05:07:32 INFO - Running main action method: read_buildbot_config 05:07:32 INFO - Using buildbot properties: 05:07:32 INFO - { 05:07:32 INFO - "project": "", 05:07:32 INFO - "product": "firefox", 05:07:32 INFO - "script_repo_revision": "production", 05:07:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:07:32 INFO - "repository": "", 05:07:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:07:32 INFO - "buildid": "20161108030212", 05:07:32 INFO - "stage_platform": "linux64-pgo", 05:07:32 INFO - "basedir": "/builds/slave/test", 05:07:32 INFO - "nightly_build": "True", 05:07:32 INFO - "buildnumber": 414, 05:07:32 INFO - "slavename": "talos-linux64-ix-052", 05:07:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:07:32 INFO - "platform": "ubuntu64_hw", 05:07:32 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:07:32 INFO - "branch": "mozilla-central", 05:07:32 INFO - "repo_path": "mozilla-central", 05:07:32 INFO - "revision": "f13e90d496cf1bc6dfc4fd398da33e4afe785bde", 05:07:32 INFO - "pgo_build": "True", 05:07:32 INFO - "builduid": "5f4e42c5c6fb4ba2822ef60cdb11a2b3", 05:07:32 INFO - "slavebuilddir": "test" 05:07:32 INFO - } 05:07:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:07:32 INFO - Running post-action listener: _resource_record_post_action 05:07:32 INFO - [mozharness: 2016-11-08 13:07:32.199118Z] Finished read-buildbot-config step (success) 05:07:32 INFO - [mozharness: 2016-11-08 13:07:32.199206Z] Running download-and-extract step. 05:07:32 INFO - Running pre-action listener: _resource_record_pre_action 05:07:32 INFO - Running main action method: download_and_extract 05:07:32 INFO - mkdir: /builds/slave/test/build/tests 05:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:32 INFO - trying https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:07:32 INFO - Downloading https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/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:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/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:07:32 INFO - Downloaded 1361 bytes. 05:07:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:07:32 INFO - Using the following test package requirements: 05:07:32 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:32 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:32 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:32 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'jsshell-linux-x86_64.zip'], 05:07:32 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:32 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:32 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:32 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:32 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:32 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:07:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:32 INFO - Fetch https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:07:33 INFO - Http code: 200 05:07:33 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 05:07:33 INFO - x-amz-cf-id: z_sDPx9sQlLTwkSPDW1BQm_UkF_lC8Nf7XpRhbPUO4KQVdzf_1eMlA== 05:07:33 INFO - x-amz-version-id: qPkkD3nZI96_4EWsJvWOm7CXHXtI0chm 05:07:33 INFO - Expected file size: 21922909 05:07:33 INFO - Obtained file size: 21922909 05:07:37 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:07:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:07:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:37 INFO - Fetch https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:07:38 INFO - Http code: 200 05:07:38 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 05:07:38 INFO - x-amz-cf-id: MJcMciEhaOewroSTEOgyuaZYDRp4yNxYn70JHSzOPVpigQRqw-eQFg== 05:07:38 INFO - x-amz-version-id: qPkkD3nZI96_4EWsJvWOm7CXHXtI0chm 05:07:38 INFO - Expected file size: 21922909 05:07:38 INFO - Obtained file size: 21922909 05:07:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:07:43 INFO - Fetch https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:07:43 INFO - Http code: 200 05:07:43 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 05:07:43 INFO - x-amz-cf-id: QCBbddf78BwR9kGKbHITMjxL_i43bBOZ1zoGMaukl2o1FL_EvIYrGQ== 05:07:43 INFO - x-amz-version-id: o3wyiiU25zddtm4YAu8vkoSRJ80P6Ghq 05:07:45 INFO - Expected file size: 14409038 05:07:45 INFO - Obtained file size: 14409038 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:46 INFO - trying https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:07:46 INFO - Downloading https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/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:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/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:07:47 INFO - Downloaded 59591326 bytes. 05:07:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:07:47 INFO - mkdir: /builds/slave/test/properties 05:07:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:47 INFO - Contents: 05:07:47 INFO - build_url:https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:07:48 INFO - Running post-action listener: _resource_record_post_action 05:07:48 INFO - Running post-action listener: set_extra_try_arguments 05:07:48 INFO - [mozharness: 2016-11-08 13:07:48.248924Z] Finished download-and-extract step (success) 05:07:48 INFO - [mozharness: 2016-11-08 13:07:48.249151Z] Running populate-webroot step. 05:07:48 INFO - Running pre-action listener: _resource_record_pre_action 05:07:48 INFO - Running main action method: populate_webroot 05:07:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:48 INFO - '--tppagecycles', 05:07:48 INFO - '7'], 05:07:48 INFO - 'tests': ['tsvgm']}}, 05:07:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['damp', 'tps']}, 05:07:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'tests': ['damp', 'tps']}, 05:07:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['dromaeo_dom']}, 05:07:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['basic_compositor_video']}, 05:07:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['a11yr', 05:07:48 INFO - 'ts_paint', 05:07:48 INFO - 'tpaint', 05:07:48 INFO - 'sessionrestore', 05:07:48 INFO - 'sessionrestore_no_auto_restore', 05:07:48 INFO - 'tabpaint']}, 05:07:48 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:48 INFO - 'ts_paint', 05:07:48 INFO - 'tpaint', 05:07:48 INFO - 'sessionrestore', 05:07:48 INFO - 'sessionrestore_no_auto_restore', 05:07:48 INFO - 'tabpaint']}, 05:07:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:48 INFO - 'ts_paint', 05:07:48 INFO - 'tpaint', 05:07:48 INFO - 'sessionrestore', 05:07:48 INFO - 'sessionrestore_no_auto_restore', 05:07:48 INFO - 'tabpaint']}, 05:07:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:48 INFO - 'ts_paint', 05:07:48 INFO - 'tpaint', 05:07:48 INFO - 'sessionrestore', 05:07:48 INFO - 'sessionrestore_no_auto_restore', 05:07:48 INFO - 'tabpaint']}, 05:07:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['a11yr', 05:07:48 INFO - 'ts_paint', 05:07:48 INFO - 'tpaint', 05:07:48 INFO - 'sessionrestore', 05:07:48 INFO - 'sessionrestore_no_auto_restore', 05:07:48 INFO - 'tabpaint']}, 05:07:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['a11yr', 05:07:48 INFO - 'ts_paint', 05:07:48 INFO - 'tpaint', 05:07:48 INFO - 'sessionrestore', 05:07:48 INFO - 'sessionrestore_no_auto_restore', 05:07:48 INFO - 'tabpaint']}, 05:07:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['tsvgx', 05:07:48 INFO - 'tsvgr_opacity', 05:07:48 INFO - 'tart', 05:07:48 INFO - 'tscrollx', 05:07:48 INFO - 'cart']}, 05:07:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:48 INFO - 'tsvgr_opacity', 05:07:48 INFO - 'tart', 05:07:48 INFO - 'tscrollx', 05:07:48 INFO - 'cart']}, 05:07:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'talos_options': ['--disable-e10s'], 05:07:48 INFO - 'tests': ['tp5o']}, 05:07:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'tests': ['tp5o']}, 05:07:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'talos_options': ['--disable-e10s', 05:07:48 INFO - '--xperf_path', 05:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:48 INFO - 'tests': ['tp5n']}, 05:07:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:48 INFO - 'talos_options': ['--xperf_path', 05:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:48 INFO - 'tests': ['tp5n']}}, 05:07:48 INFO - 'talos.zip': {'path': '', 05:07:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:48 INFO - Running post-action listener: _resource_record_post_action 05:07:48 INFO - [mozharness: 2016-11-08 13:07:48.268977Z] Finished populate-webroot step (success) 05:07:48 INFO - [mozharness: 2016-11-08 13:07:48.269065Z] Running create-virtualenv step. 05:07:48 INFO - Running pre-action listener: _resource_record_pre_action 05:07:48 INFO - Running main action method: create_virtualenv 05:07:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:48 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:07:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:48 INFO - Using real prefix '/usr' 05:07:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:50 INFO - Installing pip.................done. 05:07:50 INFO - Return code: 0 05:07:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:07:51 INFO - Reading from file tmpfile_stdout 05:07:51 INFO - Output received: 05:07:51 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:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:07:51 INFO - Using env: {'DISPLAY': ':0', 05:07:51 INFO - 'HOME': '/home/cltbld', 05:07:51 INFO - 'LANG': 'en_US.UTF-8', 05:07:51 INFO - 'LANGUAGE': 'en_US:en', 05:07:51 INFO - 'LOGNAME': 'cltbld', 05:07:51 INFO - 'MAIL': '/var/mail/cltbld', 05:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:51 INFO - 'MOZ_NO_REMOTE': '1', 05:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:51 INFO - 'NO_EM_RESTART': '1', 05:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:51 INFO - 'PWD': '/builds/slave/test', 05:07:51 INFO - 'SHELL': '/bin/bash', 05:07:51 INFO - 'SHLVL': '1', 05:07:51 INFO - 'TERM': 'linux', 05:07:51 INFO - 'TMOUT': '86400', 05:07:51 INFO - 'USER': 'cltbld', 05:07:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:51 INFO - '_': '/tools/buildbot/bin/python'} 05:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:51 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:07:51 INFO - Cleaning up... 05:07:51 INFO - Return code: 0 05:07:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:07:51 INFO - Using env: {'DISPLAY': ':0', 05:07:51 INFO - 'HOME': '/home/cltbld', 05:07:51 INFO - 'LANG': 'en_US.UTF-8', 05:07:51 INFO - 'LANGUAGE': 'en_US:en', 05:07:51 INFO - 'LOGNAME': 'cltbld', 05:07:51 INFO - 'MAIL': '/var/mail/cltbld', 05:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:51 INFO - 'MOZ_NO_REMOTE': '1', 05:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:51 INFO - 'NO_EM_RESTART': '1', 05:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:51 INFO - 'PWD': '/builds/slave/test', 05:07:51 INFO - 'SHELL': '/bin/bash', 05:07:51 INFO - 'SHLVL': '1', 05:07:51 INFO - 'TERM': 'linux', 05:07:51 INFO - 'TMOUT': '86400', 05:07:51 INFO - 'USER': 'cltbld', 05:07:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:51 INFO - '_': '/tools/buildbot/bin/python'} 05:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:51 INFO - Downloading/unpacking psutil>=3.1.1 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:53 INFO - Installing collected packages: psutil 05:07:53 INFO - Running setup.py install for psutil 05:07:53 INFO - building 'psutil._psutil_linux' extension 05:07:53 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:07:54 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:07:54 INFO - building 'psutil._psutil_posix' extension 05:07:54 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:07:54 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:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:54 INFO - Successfully installed psutil 05:07:54 INFO - Cleaning up... 05:07:54 INFO - Return code: 0 05:07:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:07:54 INFO - Using env: {'DISPLAY': ':0', 05:07:54 INFO - 'HOME': '/home/cltbld', 05:07:54 INFO - 'LANG': 'en_US.UTF-8', 05:07:54 INFO - 'LANGUAGE': 'en_US:en', 05:07:54 INFO - 'LOGNAME': 'cltbld', 05:07:54 INFO - 'MAIL': '/var/mail/cltbld', 05:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:54 INFO - 'MOZ_NO_REMOTE': '1', 05:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:54 INFO - 'NO_EM_RESTART': '1', 05:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:54 INFO - 'PWD': '/builds/slave/test', 05:07:54 INFO - 'SHELL': '/bin/bash', 05:07:54 INFO - 'SHLVL': '1', 05:07:54 INFO - 'TERM': 'linux', 05:07:54 INFO - 'TMOUT': '86400', 05:07:54 INFO - 'USER': 'cltbld', 05:07:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:54 INFO - '_': '/tools/buildbot/bin/python'} 05:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:56 INFO - Installing collected packages: mozsystemmonitor 05:07:56 INFO - Running setup.py install for mozsystemmonitor 05:07:56 INFO - Successfully installed mozsystemmonitor 05:07:56 INFO - Cleaning up... 05:07:56 INFO - Return code: 0 05:07:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07: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:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:56 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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:07:56 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:07:56 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:07:56 INFO - Using env: {'DISPLAY': ':0', 05:07:56 INFO - 'HOME': '/home/cltbld', 05:07:56 INFO - 'LANG': 'en_US.UTF-8', 05:07:56 INFO - 'LANGUAGE': 'en_US:en', 05:07:56 INFO - 'LOGNAME': 'cltbld', 05:07:56 INFO - 'MAIL': '/var/mail/cltbld', 05:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:56 INFO - 'MOZ_NO_REMOTE': '1', 05:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:56 INFO - 'NO_EM_RESTART': '1', 05:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:56 INFO - 'PWD': '/builds/slave/test', 05:07:56 INFO - 'SHELL': '/bin/bash', 05:07:56 INFO - 'SHLVL': '1', 05:07:56 INFO - 'TERM': 'linux', 05:07:56 INFO - 'TMOUT': '86400', 05:07:56 INFO - 'USER': 'cltbld', 05:07:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:56 INFO - '_': '/tools/buildbot/bin/python'} 05:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:57 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:59 INFO - warning: no files found matching '*.txt' 05:07:59 INFO - no previously-included directories found matching 'build' 05:07:59 INFO - no previously-included directories found matching 'dist' 05:07:59 INFO - no previously-included directories found matching '.git*' 05:07:59 INFO - Installing collected packages: jsonschema, functools32 05:07:59 INFO - Running setup.py install for functools32 05:07:59 INFO - warning: no files found matching '*.txt' 05:07:59 INFO - no previously-included directories found matching 'build' 05:07:59 INFO - no previously-included directories found matching 'dist' 05:07:59 INFO - no previously-included directories found matching '.git*' 05:07:59 INFO - Successfully installed jsonschema functools32 05:07:59 INFO - Cleaning up... 05:07:59 INFO - Return code: 0 05:07:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:07:59 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:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 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:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:07:59 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:07:59 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:07:59 INFO - Using env: {'DISPLAY': ':0', 05:07:59 INFO - 'HOME': '/home/cltbld', 05:07:59 INFO - 'LANG': 'en_US.UTF-8', 05:07:59 INFO - 'LANGUAGE': 'en_US:en', 05:07:59 INFO - 'LOGNAME': 'cltbld', 05:07:59 INFO - 'MAIL': '/var/mail/cltbld', 05:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:59 INFO - 'MOZ_NO_REMOTE': '1', 05:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:59 INFO - 'NO_EM_RESTART': '1', 05:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:59 INFO - 'PWD': '/builds/slave/test', 05:07:59 INFO - 'SHELL': '/bin/bash', 05:07:59 INFO - 'SHLVL': '1', 05:07:59 INFO - 'TERM': 'linux', 05:07:59 INFO - 'TMOUT': '86400', 05:07:59 INFO - 'USER': 'cltbld', 05:07:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:59 INFO - '_': '/tools/buildbot/bin/python'} 05:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:07:59 INFO - Cleaning up... 05:07:59 INFO - Return code: 0 05:07:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:59 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:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 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:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:07:59 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:07:59 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:07:59 INFO - Using env: {'DISPLAY': ':0', 05:07:59 INFO - 'HOME': '/home/cltbld', 05:07:59 INFO - 'LANG': 'en_US.UTF-8', 05:07:59 INFO - 'LANGUAGE': 'en_US:en', 05:07:59 INFO - 'LOGNAME': 'cltbld', 05:07:59 INFO - 'MAIL': '/var/mail/cltbld', 05:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:59 INFO - 'MOZ_NO_REMOTE': '1', 05:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:59 INFO - 'NO_EM_RESTART': '1', 05:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:59 INFO - 'PWD': '/builds/slave/test', 05:07:59 INFO - 'SHELL': '/bin/bash', 05:07:59 INFO - 'SHLVL': '1', 05:07:59 INFO - 'TERM': 'linux', 05:07:59 INFO - 'TMOUT': '86400', 05:07:59 INFO - 'USER': 'cltbld', 05:07:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:59 INFO - '_': '/tools/buildbot/bin/python'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:02 INFO - Downloading docopt-0.6.1.tar.gz 05:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:03 INFO - Running setup.py install for blobuploader 05:08:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:03 INFO - Running setup.py install for requests 05:08:03 INFO - Running setup.py install for docopt 05:08:03 INFO - Successfully installed blobuploader requests docopt 05:08:03 INFO - Cleaning up... 05:08:03 INFO - Return code: 0 05:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:03 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:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:03 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:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:03 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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:08:03 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:08:03 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:08:03 INFO - Using env: {'DISPLAY': ':0', 05:08:03 INFO - 'HOME': '/home/cltbld', 05:08:03 INFO - 'LANG': 'en_US.UTF-8', 05:08:03 INFO - 'LANGUAGE': 'en_US:en', 05:08:03 INFO - 'LOGNAME': 'cltbld', 05:08:03 INFO - 'MAIL': '/var/mail/cltbld', 05:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:03 INFO - 'MOZ_NO_REMOTE': '1', 05:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:03 INFO - 'NO_EM_RESTART': '1', 05:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:03 INFO - 'PWD': '/builds/slave/test', 05:08:03 INFO - 'SHELL': '/bin/bash', 05:08:03 INFO - 'SHLVL': '1', 05:08:03 INFO - 'TERM': 'linux', 05:08:03 INFO - 'TMOUT': '86400', 05:08:03 INFO - 'USER': 'cltbld', 05:08:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:03 INFO - '_': '/tools/buildbot/bin/python'} 05:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:03 INFO - Running setup.py (path:/tmp/pip-jQOxna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:03 INFO - Running setup.py (path:/tmp/pip-MYxyt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:04 INFO - Running setup.py (path:/tmp/pip-tgvDTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:04 INFO - Running setup.py (path:/tmp/pip-Y9Fsdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:04 INFO - Running setup.py (path:/tmp/pip-kn1KUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:04 INFO - Running setup.py (path:/tmp/pip-jNBnoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:04 INFO - Running setup.py (path:/tmp/pip-DmMtW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:04 INFO - Running setup.py (path:/tmp/pip-XOEr5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:04 INFO - Running setup.py (path:/tmp/pip-mAaEC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:04 INFO - Running setup.py (path:/tmp/pip-aECBj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:04 INFO - Running setup.py (path:/tmp/pip-Mncq3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:04 INFO - Running setup.py (path:/tmp/pip-LF2UvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:04 INFO - Running setup.py (path:/tmp/pip-0YqTlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:04 INFO - Running setup.py (path:/tmp/pip-TZdUxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:04 INFO - Running setup.py (path:/tmp/pip-5kBrkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:04 INFO - Running setup.py (path:/tmp/pip-w7enkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:05 INFO - Running setup.py (path:/tmp/pip-oN63g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:05 INFO - Running setup.py install for manifestparser 05:08:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozcrash 05:08:05 INFO - Running setup.py install for mozdebug 05:08:05 INFO - Running setup.py install for mozdevice 05:08:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozfile 05:08:05 INFO - Running setup.py install for mozhttpd 05:08:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozinfo 05:08:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozInstall 05:08:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozleak 05:08:06 INFO - Running setup.py install for mozlog 05:08:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for moznetwork 05:08:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozprocess 05:08:06 INFO - Running setup.py install for mozprofile 05:08:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozrunner 05:08:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozscreenshot 05:08:06 INFO - Running setup.py install for moztest 05:08:06 INFO - Running setup.py install for mozversion 05:08:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:06 INFO - Cleaning up... 05:08:06 INFO - Return code: 0 05:08:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:06 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:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:06 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:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:06 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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:08:06 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:08:06 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:08:06 INFO - Using env: {'DISPLAY': ':0', 05:08:06 INFO - 'HOME': '/home/cltbld', 05:08:06 INFO - 'LANG': 'en_US.UTF-8', 05:08:06 INFO - 'LANGUAGE': 'en_US:en', 05:08:06 INFO - 'LOGNAME': 'cltbld', 05:08:06 INFO - 'MAIL': '/var/mail/cltbld', 05:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:06 INFO - 'MOZ_NO_REMOTE': '1', 05:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:06 INFO - 'NO_EM_RESTART': '1', 05:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:06 INFO - 'PWD': '/builds/slave/test', 05:08:06 INFO - 'SHELL': '/bin/bash', 05:08:06 INFO - 'SHLVL': '1', 05:08:06 INFO - 'TERM': 'linux', 05:08:06 INFO - 'TMOUT': '86400', 05:08:06 INFO - 'USER': 'cltbld', 05:08:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:06 INFO - '_': '/tools/buildbot/bin/python'} 05:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:07 INFO - Running setup.py (path:/tmp/pip-15tA5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:07 INFO - Running setup.py (path:/tmp/pip-MELNgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:07 INFO - Running setup.py (path:/tmp/pip-2ocR1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:07 INFO - Running setup.py (path:/tmp/pip-qNfq1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:07 INFO - Running setup.py (path:/tmp/pip-26PDRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:07 INFO - Running setup.py (path:/tmp/pip-UTTjp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:07 INFO - Running setup.py (path:/tmp/pip-dDyDuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:07 INFO - Running setup.py (path:/tmp/pip-X6YPrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:07 INFO - Running setup.py (path:/tmp/pip-2by7gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:07 INFO - Running setup.py (path:/tmp/pip-k_dm3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:07 INFO - Running setup.py (path:/tmp/pip-RQThka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:07 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:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:07 INFO - Running setup.py (path:/tmp/pip-rpq8PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:08 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:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:08 INFO - Running setup.py (path:/tmp/pip-65xY38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:08 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:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:08 INFO - Running setup.py (path:/tmp/pip-ujZXV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:08 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:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:08 INFO - Running setup.py (path:/tmp/pip-aaEUQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:08 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:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:08 INFO - Running setup.py (path:/tmp/pip-DW10Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:08 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:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:08 INFO - Running setup.py (path:/tmp/pip-fP4LdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:10 INFO - Downloading blessings-1.6.tar.gz 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:10 INFO - Installing collected packages: blessings 05:08:10 INFO - Running setup.py install for blessings 05:08:10 INFO - Successfully installed blessings 05:08:10 INFO - Cleaning up... 05:08:10 INFO - Return code: 0 05:08:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:11 INFO - Reading from file tmpfile_stdout 05:08:11 INFO - Current package versions: 05:08:11 INFO - argparse == 1.2.1 05:08:11 INFO - blessings == 1.6 05:08:11 INFO - blobuploader == 1.2.4 05:08:11 INFO - docopt == 0.6.1 05:08:11 INFO - functools32 == 3.2.3-2 05:08:11 INFO - jsonschema == 2.5.1 05:08:11 INFO - manifestparser == 1.1 05:08:11 INFO - mozInstall == 1.12 05:08:11 INFO - mozcrash == 0.17 05:08:11 INFO - mozdebug == 0.1 05:08:11 INFO - mozdevice == 0.48 05:08:11 INFO - mozfile == 1.2 05:08:11 INFO - mozhttpd == 0.7 05:08:11 INFO - mozinfo == 0.9 05:08:11 INFO - mozleak == 0.1 05:08:11 INFO - mozlog == 3.4 05:08:11 INFO - moznetwork == 0.27 05:08:11 INFO - mozprocess == 0.23 05:08:11 INFO - mozprofile == 0.28 05:08:11 INFO - mozrunner == 6.12 05:08:11 INFO - mozscreenshot == 0.1 05:08:11 INFO - mozsystemmonitor == 0.3 05:08:11 INFO - moztest == 0.7 05:08:11 INFO - mozversion == 1.4 05:08:11 INFO - psutil == 3.1.1 05:08:11 INFO - requests == 1.2.3 05:08:11 INFO - wsgiref == 0.1.2 05:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:08:11 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:08:11 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:08:11 INFO - Using env: {'DISPLAY': ':0', 05:08:11 INFO - 'HOME': '/home/cltbld', 05:08:11 INFO - 'LANG': 'en_US.UTF-8', 05:08:11 INFO - 'LANGUAGE': 'en_US:en', 05:08:11 INFO - 'LOGNAME': 'cltbld', 05:08:11 INFO - 'MAIL': '/var/mail/cltbld', 05:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:11 INFO - 'MOZ_NO_REMOTE': '1', 05:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:11 INFO - 'NO_EM_RESTART': '1', 05:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:11 INFO - 'PWD': '/builds/slave/test', 05:08:11 INFO - 'SHELL': '/bin/bash', 05:08:11 INFO - 'SHLVL': '1', 05:08:11 INFO - 'TERM': 'linux', 05:08:11 INFO - 'TMOUT': '86400', 05:08:11 INFO - 'USER': 'cltbld', 05:08:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:11 INFO - '_': '/tools/buildbot/bin/python'} 05:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 INFO - Cleaning up... 05:08:11 INFO - Return code: 0 05:08:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 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 0x7f31d75c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f507b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, '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': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', '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:08:11 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:08:11 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:08:11 INFO - Using env: {'DISPLAY': ':0', 05:08:11 INFO - 'HOME': '/home/cltbld', 05:08:11 INFO - 'LANG': 'en_US.UTF-8', 05:08:11 INFO - 'LANGUAGE': 'en_US:en', 05:08:11 INFO - 'LOGNAME': 'cltbld', 05:08:11 INFO - 'MAIL': '/var/mail/cltbld', 05:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:11 INFO - 'MOZ_NO_REMOTE': '1', 05:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:11 INFO - 'NO_EM_RESTART': '1', 05:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:11 INFO - 'PWD': '/builds/slave/test', 05:08:11 INFO - 'SHELL': '/bin/bash', 05:08:11 INFO - 'SHLVL': '1', 05:08:11 INFO - 'TERM': 'linux', 05:08:11 INFO - 'TMOUT': '86400', 05:08:11 INFO - 'USER': 'cltbld', 05:08:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:11 INFO - '_': '/tools/buildbot/bin/python'} 05:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:08:11 INFO - Cleaning up... 05:08:11 INFO - Return code: 0 05:08:11 INFO - Running post-action listener: _resource_record_post_action 05:08:11 INFO - Running post-action listener: _start_resource_monitoring 05:08:11 INFO - Starting resource monitoring. 05:08:11 INFO - [mozharness: 2016-11-08 13:08:11.744799Z] Finished create-virtualenv step (success) 05:08:11 INFO - [mozharness: 2016-11-08 13:08:11.745300Z] Running install step. 05:08:11 INFO - Running pre-action listener: _resource_record_pre_action 05:08:11 INFO - Running main action method: install 05:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:11 INFO - Reading from file tmpfile_stdout 05:08:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:12 INFO - Reading from file tmpfile_stdout 05:08:12 INFO - Output received: 05:08:12 INFO - Usage: mozinstall [options] installer 05:08:12 INFO - Options: 05:08:12 INFO - -h, --help show this help message and exit 05:08:12 INFO - -d DEST, --destination=DEST 05:08:12 INFO - Directory to install application into. [default: 05:08:12 INFO - "/builds/slave/test"] 05:08:12 INFO - --app=APP Application being installed. [default: firefox] 05:08:12 INFO - mkdir: /builds/slave/test/build/application 05:08:12 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:08:12 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:08:28 INFO - Reading from file tmpfile_stdout 05:08:29 INFO - Output received: 05:08:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:29 INFO - Running post-action listener: _resource_record_post_action 05:08:29 INFO - [mozharness: 2016-11-08 13:08:29.001625Z] Finished install step (success) 05:08:29 INFO - [mozharness: 2016-11-08 13:08:29.001869Z] Running run-tests step. 05:08:29 INFO - Running pre-action listener: _resource_record_pre_action 05:08:29 INFO - Running main action method: run_tests 05:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:29 INFO - Python 2.7.3 05:08:29 INFO - Return code: 0 05:08:29 INFO - grabbing minidump binary from tooltool 05:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:29 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 0x1fdf790>, '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 0x1fe0690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:29 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:08:29 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:08:29 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:08:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:29 INFO - Return code: 0 05:08:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:08:29 INFO - Using env: {'DISPLAY': ':0', 05:08:29 INFO - 'HOME': '/home/cltbld', 05:08:29 INFO - 'LANG': 'en_US.UTF-8', 05:08:29 INFO - 'LANGUAGE': 'en_US:en', 05:08:29 INFO - 'LOGNAME': 'cltbld', 05:08:29 INFO - 'MAIL': '/var/mail/cltbld', 05:08:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:29 INFO - 'MOZ_NO_REMOTE': '1', 05:08:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:29 INFO - 'NO_EM_RESTART': '1', 05:08:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:29 INFO - 'PWD': '/builds/slave/test', 05:08:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:29 INFO - 'SHELL': '/bin/bash', 05:08:29 INFO - 'SHLVL': '1', 05:08:29 INFO - 'TERM': 'linux', 05:08:29 INFO - 'TMOUT': '86400', 05:08:29 INFO - 'USER': 'cltbld', 05:08:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401', 05:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:29 INFO - '_': '/tools/buildbot/bin/python'} 05:08:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:08:29 INFO - mozversion application_buildid: 20161108030212 05:08:29 INFO - mozversion application_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 05:08:29 INFO - mozversion application_display_name: Nightly 05:08:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:29 INFO - mozversion application_name: Firefox 05:08:29 INFO - mozversion application_remotingname: firefox 05:08:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:08:29 INFO - mozversion application_vendor: Mozilla 05:08:29 INFO - mozversion application_version: 52.0a1 05:08:29 INFO - mozversion platform_buildid: 20161108030212 05:08:29 INFO - mozversion platform_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 05:08:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:08:29 INFO - mozversion platform_version: 52.0a1 05:08:29 INFO - using testdate: 1478610509 05:08:29 INFO - actual date: 1478610509 05:08:29 INFO - starting webserver on 'localhost:48570' 05:08:29 INFO - SUITE-START | Running 2 tests 05:08:29 INFO - TEST-START | dromaeo_css 05:08:29 INFO - operating with platform_type : linux_ 05:08:29 INFO - Initialising browser for dromaeo_css test... 05:08:29 INFO - TEST-INFO | started process 14563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkwbia8/profile http://localhost:48570/getInfo.html) 05:08:33 INFO - PROCESS | 14563 | __metrics Screen width/height:1600/1200 05:08:33 INFO - PROCESS | 14563 | colorDepth:24 05:08:33 INFO - PROCESS | 14563 | Browser inner width/height: 1024/697 05:08:33 INFO - PROCESS | 14563 | __metrics 05:08:34 ERROR - PROCESS | 14563 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 05:08:35 INFO - TEST-INFO | 14563: exit 0 05:08:35 INFO - Browser initialized. 05:08:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:35 INFO - TEST-INFO | started process 14684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkwbia8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:47 INFO - PROCESS | 14684 | RSS: Main: 185745408 05:08:47 INFO - PROCESS | 14684 | 05:09:37 INFO - PROCESS | 14684 | 1478610577186 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:11:48 INFO - PROCESS | 14684 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48570/tests/dromaeo/cssquery-ext.html) 05:11:49 INFO - PROCESS | 14684 | RSS: Main: 197214208 05:11:49 INFO - PROCESS | 14684 | 05:14:51 INFO - PROCESS | 14684 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-ext.html (next: http://localhost:48570/tests/dromaeo/cssquery-jquery.html) 05:14:52 INFO - PROCESS | 14684 | RSS: Main: 195731456 05:14:52 INFO - PROCESS | 14684 | 05:17:54 INFO - PROCESS | 14684 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48570/tests/dromaeo/cssquery-mootools.html) 05:17:54 INFO - PROCESS | 14684 | RSS: Main: 198230016 05:17:54 INFO - PROCESS | 14684 | 05:20:56 INFO - PROCESS | 14684 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48570/tests/dromaeo/cssquery-prototype.html) 05:20:57 INFO - PROCESS | 14684 | RSS: Main: 195039232 05:20:57 INFO - PROCESS | 14684 | 05:23:59 INFO - PROCESS | 14684 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48570/tests/dromaeo/cssquery-yui.html) 05:24:00 INFO - PROCESS | 14684 | RSS: Main: 198533120 05:24:00 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-yui.html (next: http://localhost:48570/tests/dromaeo/cssquery-dojo.html) 05:27:03 INFO - PROCESS | 14684 | RSS: Main: 198635520 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | __start_tp_report 05:27:03 INFO - PROCESS | 14684 | _x_x_mozilla_page_load 05:27:03 INFO - PROCESS | 14684 | _x_x_mozilla_page_load_details 05:27:03 INFO - PROCESS | 14684 | |i|pagename|runs| 05:27:03 INFO - PROCESS | 14684 | |0;dojo.html;3121.7814752967292;3139.8273094979795;3151.023182813328;3162.573052637894;3174.9999999999986;5343.625946183769;5391.784328626855;5452.509274165324;5474.47992440718;5490.368607610126;5431.402545719968;5433.049216387136;5488.121900495921;5539.113741801312;5558.555315574755;4889.999999999991;4965.329680493123;4990.975045124769;4998.175301075336;5094.184930411135;5010.323606313155;5107.46371630979;5131.025105230013;5138.948610513903;5174.844754657347;4842.055799119174;4997.576175554853;5038.143515602356;5041.0422019816115;5047.242913562958;4869.026194761062;4875.658703890729;4929.6302777291485;4941.579965702919;5003.574696150831;4828.46886842447;4847.321375007502;4848.612111031109;4874.4150701916;4926.014797040571;5374.355077390699;5378.112611419111;5387.649802762808;5398.757055932492;5403.2705584745945;5723.484886360247;5799.18811366409;5822.0684690449325;5823.2138661280605;5826.708664566755;5834.474897259267;5889.499392551638;5890.676012819294;5894.469497745181;5903.616264942765;5323.0152421802095;5358.571314294847;5462.481064298925;5463.672179669233;5479.863003424946;5805.767769289181;5832.591718579743;5850.853728656818;5890.941090589039;5904.084866845646;5625.296837895263;5645.802396916089;5653.321601407857;5655.123455864265;5661.801836935688;5600.523955463831;5719.714014299351;5721.942780572224;5730.255066841284;5753.280839895013;5674.858128546819;5761.827145185567;5810.7966221182905;5828.184054232411;5878;5833.854153646108;5841.912371314434;5848.88302233953;5865.88268234633;5866.1494083357675;4520.480144783326;4526.932096018562;4534.047849951481;4538.931916021263;4544.568266014723;3935.2523020626563;3969.364901615728;3970.50368703912;3991.7405368650943;4004.2592120457807;5554.166874968706;5579.46995035471;5579.581531385163;5611.971940140274;5612.915806262909;5859.5019423349495;5870.647761134345;5881.676507792027;5882.882342353129;5884.676342801187;5422.674639521641;5505.201745746845;5550.750216240279;5580.581456390787;5589.664620122806;5062.443131255559;5067.6452648315;5071.746412679351;5092.567131793765;5093.465186155475;6072.483838873569;6077.088436734525;6085.786997455068;6086.178365920544;6096.634201947897;5633.183188437735;5770.2498675171955;5804.796832110856;5894.528437725057;5907.054871220584;5880.441358070976;6055.818325450244;6056.6971651418135;6071.089336599545;6084.726187321669;5722.74247658848;5727.4845263926445;5756.3380211276235;5777.537796976148;5785.363610002981;5697.914531282117;5748.5688573358;5801.274840644919;5874.206982057539;5890.322612899571;5642.435756424325;5664.291963504562;5669.744861481326;5672.092465205547;5701.059325211294;5580.720963951868;5652.68910209926;5664.575156863334;5666.716664166857;5694.743736531949;5523.143912693539;5525.972370138124;5559.33288005442;5626.212330273683;5631.63394379364;5687.118496633028;5749.942500574941;5754.913676294943;5801.390853960443;5801.448862358069;5619.072852979212;5619.185218143428;5626.971865140648;5630.662160270397;5632.662040277596 05:27:03 INFO - PROCESS | 14684 | |1;ext.html;564.0214228313876;579.9416065680133;584.0917373484233;586.6861229242356;613.4049971527622;36965;40208.99999999996;40251.79874100629;40261.19477610446;40284.19431611366;40536;40820.38769418461;40968.59031409685;40974.59025409752;40996.385054224134;8327.417080804345;8446.197611226955;8453.239208471236;8456.915430845675;8487.872681909776;8404.663813447485;8424.915750842505;8460.8730869037;8486.0665326814;8487.98144222691;8546.40175187737;8574.69988550401;8609.225169734722;8610.052894181636;8628.137186281354;8459.492430454193;8475.830483390358;8487.533185674785;8548.316134709208;8551.486910785372;8397.6221070052;8462;8464.915350846475;8476.576171191417;8483.15168483153;39569.40645890285;39779.40330895039;39843.8007809962;39944.400833987514;39989.80005099956;3360.993581297765;3528.400171970771;3826.196498735269;3858.305505009097;4102.466679331697;30697.539536906963;30846.383072338653;30997.22506937322;31281.687183128106;31310.21724456884;4038.29329867275;4117.814698338552;4148.709590328678;4265.893352666177;4330.523642399365;313074;314644;315301;315878;318247;53985.730071350175;54096.72951635216;54160.45839541554;54245;54305.72847135739;55342;55600.44399556034;55942;56088.71955640196;56261.43738562562;15975.840241597667;16376.344946202018;16401.58996025109;16473.093979831225;16491.67016659684;10606.681799546026;10618.946905265424;10676.199285053497;10711.089557387553;10739.355638661706;15360.769588456182;16111.27499262536;16117.516474505783;16153.192340382933;16674;5955.34491205967;5984.222051133324;5984.251968503937;6102.542309326818;6261.279952805486;954.3224310739314;959.8032403357295;975.8877729061107;1022.2690776095128;1103.3931337764197;31448.685513144577;31571.21071973219;31666.683333166373;31939.840300798347;32330.83834580812;1032.2464600841429;1083.766990097117;1098.4013712526692;1105.474899422784;1208.3656080557778;15647.452339168301;16374.672506549803;16459.753103703453;16480.587985300222;16714.080725560212;486650;490472;493233;494804;495617;54341.1848822268;54738.72630636821;54775.72612136914;54884.725576372664;54887.72556137194;1303.4264923433848;1317.5981325695564;1326.8606796286444;1339.9799003014768;1348.662834291427;29263.268418289714;30440.39119217559;30588.694113058584;30971.225719357197;31748.206294842814;47766.5223347776;48019.51980480151;48100.27849582329;48139;48139.75930120467;405283;406369;408262;408517;408673;26705.599416008386;27540.44919101647;27642.58536122;29049.419011619226;38481;42262.366064508446;42732.78633606812;42911.14177716491;42960.35559466548;44092.77953610211;36918.44622330721;37146.120989370786;37160.07099822526;37490.43764343482;38922.2215555693;36964;37208.81395593005;37531.43702844405;37704.622953770115;38695;34830.47754283637;35360;37679;38067.42898856575;38139.42790858195;32700.50949235716;34982;35023.64976350306;35034.29931401409;35496;27199.72800271972;27709.445811083264;27713.58429623517;27936.441271174055;27995.58006629943 05:27:03 INFO - PROCESS | 14684 | |2;jquery.html;388.7822819221236;390.69135383047393;398.5556104942988;399.3889349295577;425.67861264745113;13471.352816873308;17726.822731772678;17813.37653182139;18868.05659717012;18953.43139705809;15575.454859079935;15809.60475988101;17048.573785655364;19227.423177304703;19336;5548.944510554893;5601.663900166003;5749.252597162363;5780.132980052984;5838.153467747175;5663.660180389169;5747.2528571285675;5771.769129234825;5773.364929857712;5776.653400795965;5585.273914391123;5618.887622247553;5618.9604923089155;5658.660480371191;5748.45389687979;5639.605227634067;5685.687287199203;5696.8006119785605;5699.287589051369;5709.971450142764;4922.483139270361;5068.797248110071;5100.438951715309;5103.9489605103845;5107.540321371094;20537.589248215103;21209.5758084839;21247.15011399542;22746.545069098527;22797.54404911909;2353.9293821185393;2385.4751954570143;2522.545941730488;2536.1377131775102;3054.266975925784;9512.47681377524;14325.35535900887;14618.707625847423;14652.194129322883;15138.545843624708;1838.880472769279;1883.962320753591;1885.6700077486523;1925.3646296722188;1930.0735646889432;82333.17666823375;84514.57742711308;86017.56991215004;87459.12540874573;87625.12374876233;10827.891721082846;10971.122310215163;11052.226344155832;11318.660440186808;11584.304941703525;12559.87440125587;15419.691606167813;15434.536963891102;15502.457413990456;15688.607784805472;7749.302562769265;7847.803804904923;7963.283304502623;8069.3544516439715;8137.959310203411;7936.682532698627;7941.444098913136;8065.919340806634;8237.670493180205;8290.668373265002;3691.9815400922826;3841.2317536492255;4028.0796422593385;4195.664346852305;4305.56944305567;1898.9145488453053;2038.2051000109968;2043.9080241389174;2051.712760213571;2085.91656333748;881.4314766975393;1019.1795604538418;1031.8813336466253;1037.4034929915179;1041.6146025970288;18265.908670456563;19505;19557;19577.510562236057;20048.49878753043;926.893407258174;956.5552018311519;971.1259866120548;975.4342481360794;996.8604395384652;10253.33353332031;10729.302595331279;10921.399323037309;10944.835827462595;11018.39398833072;452699;453520;455290;456060;457418;56197.71901140468;75861.62069189618;90664.54667726619;95884.52057739667;96596;980.4607465893872;993.5529011944653;1028.9125424338865;1037.5071840875676;1046.0637729232294;16183.81518494988;16390.344386224417;17320.740188896925;17479.300827967247;17577.384791532237;38765.2246955065;39807;40730.79634601808;42910.35634465423;44504.77747611241;59242.70378648079;59600;60454;60835.69582152061;62202;8076.313513351431;8122.593870306579;8225.876611850706;8256.752297431087;8346.624401901807;10937.726556836144;12783.61649150527;12981.4158362872;12994.220346779224;13417.798733019208;11286.322820630789;11383.658490245305;11396.658100257006;11470.598529051444;11611.129165312805;11202.66392008241;11359.261647993184;11368.090552755595;11459.713507162054;11656.592019279284;10859.51132199037;11171.106311494897;11358.659240222807;11484.368359740294;11821.76356472883;8158.469699469753;8288.544130072903;8452.492850428995;8511.787205319917;8890.73327800167;9768.413895166314;11212.495437705486;11601;11874.821877672015;11890 05:27:03 INFO - PROCESS | 14684 | |3;mootools.html;1450.7316146512896;1462.9487967921123;1595.2023988005997;1674.891132076415;1679.3450554283825;7516.549007059581;7728.613569321526;8136.511809291439;8658.090900455456;8675.17585829346;8040.396970227227;8401.873971890427;8417.91582084179;8591.871121933176;8631.827363452727;2305.296884450242;2326.592846251903;2327.2552783109413;2341.906323747048;2346.894389752465;2275.8179345652306;2332.650102484624;2336.988315058431;2340.6723058771786;2355.7879790818824;2272.556851413975;2273.920412785553;2289.2944756156685;2334.6147885598857;2344.847584906984;2290.4273931517123;2292.5644127615783;2307.8384513084006;2308.480591866825;2311.133325003124;2279.338991692407;2285.42864283929;2294.770522947692;2297.5979203639295;2324.6164382876805;8446.366522510836;8563.357748168912;8589.613467393981;8649.221570058726;8672.479651220947;5111.514406131411;5223.216517522402;5231.764570594332;5234.214867769865;5254.290670759437;3217.6621454747383;3323.4848598467274;3439.214511304428;3514.1566024154017;3518.3491054155065;1153.0717772193382;1161.5760247509597;1174.8472698549133;1179.8761130081389;1193.4569770754285;11771.7057073573;11808.409579520989;11850.940745296304;11852.170348075639;11887.167898247126;4203;4370.169667763115;4421.137878113737;4466.821327146878;4502.212112880233;9933.106020458194;9971.650992215238;9978.650747223812;10062.24533160016;10090.192784577217;5091;5114.795408183631;5115.232715092766;5118.360204974379;5128.358955130609;4604.125216208977;4717.8112875485285;4749.430068391815;4783.306420568998;4852.272159176152;3606.6032736398975;3700.2229531798084;3709.703223742094;3760.6427389397963;3782.678472329828;1148.9138314626437;1153.6020073074776;1154.5266440759249;1163.4473625028045;1171.8769529199312;939.2439086535268;940.9440372785349;941.4116177389132;949.5964215208509;957.3011701457974;5712.0860662293835;5903.527717782567;6032.668203248776;6058.575899687068;6178.320384757763;433.7267521461459;436.4958472963732;446.8659402179333;449.98425055122914;457.82602611007604;4100.938485922714;4102.979485102615;4117.176564687014;4139.110091330378;4207.242696314632;10404.68785936408;10641.308314959502;10729.248952573245;10755.462226888625;10763.408012559385;10600.416977066336;10628.25602207838;10641.574337026432;10651.147908167328;10657.84013239802;7606.277403646644;7780.2219778021745;7810.125569863192;7908.802279943047;8023.1174570796;5811.622244554091;5973.163757073926;5994.100884867305;6001.699915004319;6056.939430605637;9756.512174391393;9797.559109840216;9850.064243896819;9914.206863450763;10031.147352474829;9823.312368134162;9828;9918.355306905029;9923.603055877684;9946.104850563484;7361.484696071438;7534.284242996907;7586.051743532059;7681.615919203906;7728.420368472274;8433.28317093054;8527.403081784216;8539.274161696325;8541.444806087584;8553.95723021381;7190.5920842643;7360.116785985716;7424.96287518559;7556.168821429528;7682.154962954182;7181.748638797617;7261.6006119663925;7446.441516886147;7466.440016998856;7728.613569321624;6948.756793512202;7040.577565346096;7051.682674279567;7063.929360706327;7071.257517960746;5018.673786203885;5072.213806859942;5080.568151707146;5086.18621020635;5210.947890521046;5006.4743201963265;5048.293238946624;5062.696238225718;5073.188289873602;5277.894442111213 05:27:03 INFO - PROCESS | 14684 | |4;prototype.html;329.64351692784186;341.6412766595075;350.5005367351524;350.84913487200527;351.8152969690912;5338.1192103303;5455.618106732531;5472.206530053145;5567.805126820562;5567.860803479915;5237.947620523793;5334.506338225294;5348.438413966536;5354.196870469432;5396.1905714142895;4284.400183974246;4289.825529108452;4309.978450107745;4326.978365108186;4333.501647310568;4234.449521562193;4248.362745588156;4292.806823692941;4326.134773045388;4344.044310251739;4242.618164365206;4260.70175087744;4273.358996150587;4278;4278.165757677254;4243.405923170759;4246.893827654318;4258.87223383299;4272.273713468702;4298.903779536229;3711.109333759905;3825.827837747308;3829.9617003830163;3832.386818109117;3837.213371258913;5260.473952604709;5262.289590905217;5272.736363181864;5276.657017293864;5296.3379577552805;4831.202851529493;4839.540243676845;4842.506109353686;4859.975700121477;4863.781129849165;5416.512513873731;5624.493795558419;5686.265688964864;5690.5447564194765;5718.79984200551;4050.696197785178;4066;4086.3053280942013;4112.650424713903;4143.1713657268365;5766.826995190109;5802.332731735863;5843.305441421982;5850.6782126983;5892.440218179266;4133.359329303963;4190.748555086705;4262.126264115911;4262.190183865056;4279.015826359955;4252.362840306442;4256.361545768098;4261.765602891809;4266.253405653998;4279.16556271524;4756.6908150970075;4762.476127625959;4816.494268101869;4817.253325734447;4853.247746599282;5408.8377348679605;5656.151577263361;5660.405657405995;5665.830025099253;5666.603337766317;1391.9095258808347;1404.6839461121167;1406.8452470228267;1409.4714482069223;1410.971780564383;950.0309684122157;965.1699538396973;976.6972238606055;987.4963768478128;995.835687111633;5238.114278859607;5332.413434522199;5334.786608535615;5358.410574836765;5379.515843574097;5556.471970208225;5587.804426845041;5609.382967873531;5617.269754931915;5633.436656334334;5098.97450512745;5205.973970130125;5302.416734159239;5320.600954928396;5330.908073317467;2932.780041496896;2958;2971.5484725101446;2989.8355590442734;2999.9800067976994;5807.5063619591965;5836.649801011953;5840.240768700041;5846.532277417797;5858.648481091148;5460.918086228709;5615.578831587647;5640.605157638925;5674.801381951612;5675.886482270332;5723.914141287884;5759.280089988752;5769.913451298234;5772.826815195467;5779.739911703983;5443.230949941364;5532.723363831873;5578.82844602638;5588.86027849307;5789.8263052108505;5786.784775197256;5798.217240672624;5800.303963524404;5813.76744930198;5863.413658634103;6032.54755893301;6034.306054803754;6060.727267273071;6100.481459076028;6117.663528505975;3976.880693579197;4093.5292441369625;4135.462389889295;4146.1500392418875;4147.688923330823;5766.4233576642;5770.278715160605;5772.249607550992;5805.738741756547;5887.470127688357;5365.22204280385;5671.262735844314;5679.466544033171;5687;5730.742116604846;5619.353774315842;5634.464725851038;5653.3781284057895;5681.721612637123;5692.829215123553;5584.776608935759;5602.842905481501;5603.943960560342;5646.87062587476;5652.858678532905;5461.371942226695;5674.57440691958;5694.231278777312;5700.201971723879;5702.230198923258;5576.609637325349;5608.2148499209325;5618.831435056954;5620.9156862647915;5623.88752224945 05:27:03 INFO - PROCESS | 14684 | |5;yui.html;678.942289905358;710.776105526759;766.9846603067937;768.7924260449679;818.1327792539912;13643.795343069849;14782.630434239149;15075.472358467456;15444.459443919464;15464.226788660564;14684.559463216094;14752.926235368835;14810.703785924303;15141.92429037856;15280.465183718572;760.0992823504151;775.0157300228706;777.4130531448749;778.1012930065755;778.715768744407;776.6000509737489;785.7642707187849;788.5584072919155;800.9239122283374;802.0295442514536;825.8719898415725;828.0642873552907;828.1759649149105;828.2793969246763;829.0755807274875;819.4100247821589;821.6425854753171;822.2722890242179;824.1552408781017;825.2696363718093;596.0998891673604;596.3916804859062;598.9401059894019;600.4505877122427;600.495583709686;13576.524821631196;13783.51757688476;13884.722305553832;13886.166829990232;13886.93056534721;13336.933315333457;13567.389467473988;13633.795493067611;13690.93154534231;13754.381052852646;11078.113750899909;11164.888351116466;11207.383593902332;11257.943710281477;11819;3626.4016437287814;3635.763675361093;3643.36241157799;3669.87155449558;3785.6592906638534;63102.05346919846;63119.36880631181;63190;63818.361816382174;64829.67585162091;10419.843702344471;10718.624848130277;10985.450727463594;11018.724531886766;11712.063034957184;19394.2242310306;19602.901985490265;19826.60346793085;19885.900570497055;19907.800921990594;8114.553699546582;8191.467554608931;8273.710420135387;8302.584870756438;8345.499270043816;4254.510731265882;4341;4392.231359512072;4517.593416592523;4544.636429085665;3313.4698448248164;3436.9828150859585;3442.982785086109;3482.3209474152295;3493;619.603453789575;629.2600958350165;636.8407898025494;645.9483241340681;651.667649498759;705.6753893209078;708.7342246657504;718.5006420537676;723.3887365176417;735.2316828913798;9538.61845526185;9620.663276785279;9627.374220675634;9795.363301385387;10048.949755251324;630.9337519560472;653.8692261547709;703.3037293079916;733.8532293541313;734.1190571314337;4421.40311058003;4639.837605683852;4760.285957106462;4803.605924018044;4845.273209018605;54037;81529;84087.5795621018;89135.55432222797;91115.54442227747;51549.7422512885;62313.06530402048;78284;82076.58961705153;83696;68726;73098.63450682712;73353.26646733464;74108.62945685237;76198.61900690461;9095.772605684646;9287.164155226063;9294.25645948336;9314.534273286445;9394.81210375775;48465.75767121283;48903.75548122237;49516.75241623769;50055.49944500654;50937.745311273204;66457;67283;68414;68721.3127868715;68730.3126968724;11391.373474458653;11394.829077564009;11508.48211830453;11694.122940779645;12294.323812190416;11944.820827687417;12440.009977550511;13007.619275570434;13044.673883152996;13047.28239946774;12035.879641203826;12284.385780711107;12288.754224915272;12371.195872268274;12547.62357129251;11953.820692689791;12119.151659383759;12168.939155304166;12575.49698012106;13014.869851301744;11998.280103193487;12297.50809967627;12317.384130793604;12613.243205407705;13033.608991730263;10021.503026811823;10076.647317343857;10577.471126443801;10947.288426252586;11005.504752286326;10296.691099267035;10673.8932610676;10684.89315106839;10702.464876756287;10842.674719758419 05:27:03 INFO - PROCESS | 14684 | __end_tp_report 05:27:03 INFO - PROCESS | 14684 | __start_cc_report 05:27:03 INFO - PROCESS | 14684 | _x_x_mozilla_cycle_collect,308 05:27:03 INFO - PROCESS | 14684 | __end_cc_report 05:27:03 INFO - PROCESS | 14684 | __startTimestamp1478611623631__endTimestamp 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | ------- Summary: start ------- 05:27:03 INFO - PROCESS | 14684 | Number of tests: 6 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | [#0] dojo.html Cycles:165 Average:5412.80 Median:5625.30 stddev:605.02 (10.8%) stddev-sans-first:579.56 05:27:03 INFO - PROCESS | 14684 | Values: 3121.8 3139.8 3151.0 3162.6 3175.0 5343.6 5391.8 5452.5 5474.5 5490.4 5431.4 5433.0 5488.1 5539.1 5558.6 4890.0 4965.3 4991.0 4998.2 5094.2 5010.3 5107.5 5131.0 5138.9 5174.8 4842.1 4997.6 5038.1 5041.0 5047.2 4869.0 4875.7 4929.6 4941.6 5003.6 4828.5 4847.3 4848.6 4874.4 4926.0 5374.4 5378.1 5387.6 5398.8 5403.3 5723.5 5799.2 5822.1 5823.2 5826.7 5834.5 5889.5 5890.7 5894.5 5903.6 5323.0 5358.6 5462.5 5463.7 5479.9 5805.8 5832.6 5850.9 5890.9 5904.1 5625.3 5645.8 5653.3 5655.1 5661.8 5600.5 5719.7 5721.9 5730.3 5753.3 5674.9 5761.8 5810.8 5828.2 5878.0 5833.9 5841.9 5848.9 5865.9 5866.1 4520.5 4526.9 4534.0 4538.9 4544.6 3935.3 3969.4 3970.5 3991.7 4004.3 5554.2 5579.5 5579.6 5612.0 5612.9 5859.5 5870.6 5881.7 5882.9 5884.7 5422.7 5505.2 5550.8 5580.6 5589.7 5062.4 5067.6 5071.7 5092.6 5093.5 6072.5 6077.1 6085.8 6086.2 6096.6 5633.2 5770.2 5804.8 5894.5 5907.1 5880.4 6055.8 6056.7 6071.1 6084.7 5722.7 5727.5 5756.3 5777.5 5785.4 5697.9 5748.6 5801.3 5874.2 5890.3 5642.4 5664.3 5669.7 5672.1 5701.1 5580.7 5652.7 5664.6 5666.7 5694.7 5523.1 5526.0 5559.3 5626.2 5631.6 5687.1 5749.9 5754.9 5801.4 5801.4 5619.1 5619.2 5627.0 5630.7 5632.7 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | [#1] ext.html Cycles:180 Average:55792.66 Median:39967.10 stddev:108956.36 (272.6%) stddev-sans-first:109183.11 05:27:03 INFO - PROCESS | 14684 | Values: 564.0 579.9 584.1 586.7 613.4 36965.0 40209.0 40251.8 40261.2 40284.2 40536.0 40820.4 40968.6 40974.6 40996.4 8327.4 8446.2 8453.2 8456.9 8487.9 8404.7 8424.9 8460.9 8486.1 8488.0 8546.4 8574.7 8609.2 8610.1 8628.1 8459.5 8475.8 8487.5 8548.3 8551.5 8397.6 8462.0 8464.9 8476.6 8483.2 39569.4 39779.4 39843.8 39944.4 39989.8 3361.0 3528.4 3826.2 3858.3 4102.5 30697.5 30846.4 30997.2 31281.7 31310.2 4038.3 4117.8 4148.7 4265.9 4330.5 313074.0 314644.0 315301.0 315878.0 318247.0 53985.7 54096.7 54160.5 54245.0 54305.7 55342.0 55600.4 55942.0 56088.7 56261.4 15975.8 16376.3 16401.6 16473.1 16491.7 10606.7 10618.9 10676.2 10711.1 10739.4 15360.8 16111.3 16117.5 16153.2 16674.0 5955.3 5984.2 5984.3 6102.5 6261.3 954.3 959.8 975.9 1022.3 1103.4 31448.7 31571.2 31666.7 31939.8 32330.8 1032.2 1083.8 1098.4 1105.5 1208.4 15647.5 16374.7 16459.8 16480.6 16714.1 486650.0 490472.0 493233.0 494804.0 495617.0 54341.2 54738.7 54775.7 54884.7 54887.7 1303.4 1317.6 1326.9 1340.0 1348.7 29263.3 30440.4 30588.7 30971.2 31748.2 47766.5 48019.5 48100.3 48139.0 48139.8 405283.0 406369.0 408262.0 408517.0 408673.0 26705.6 27540.4 27642.6 29049.4 38481.0 42262.4 42732.8 42911.1 42960.4 44092.8 36918.4 37146.1 37160.1 37490.4 38922.2 36964.0 37208.8 37531.4 37704.6 38695.0 34830.5 35360.0 37679.0 38067.4 38139.4 32700.5 34982.0 35023.6 35034.3 35496.0 27199.7 27709.4 27713.6 27936.4 27995.6 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | [#2] jquery.html Cycles:180 Average:27813.91 Median:3766.61 stddev:75217.62 (1997.0%) stddev-sans-first:75400.44 05:27:03 INFO - PROCESS | 14684 | Values: 388.8 390.7 398.6 399.4 425.7 13471.4 17726.8 17813.4 18868.1 18953.4 15575.5 15809.6 17048.6 19227.4 19336.0 5548.9 5601.7 5749.3 5780.1 5838.2 5663.7 5747.3 5771.8 5773.4 5776.7 5585.3 5618.9 5619.0 5658.7 5748.5 5639.6 5685.7 5696.8 5699.3 5710.0 4922.5 5068.8 5100.4 5103.9 5107.5 20537.6 21209.6 21247.2 22746.5 22797.5 2353.9 2385.5 2522.5 2536.1 3054.3 9512.5 14325.4 14618.7 14652.2 15138.5 1838.9 1884.0 1885.7 1925.4 1930.1 82333.2 84514.6 86017.6 87459.1 87625.1 10827.9 10971.1 11052.2 11318.7 11584.3 12559.9 15419.7 15434.5 15502.5 15688.6 7749.3 7847.8 7963.3 8069.4 8138.0 7936.7 7941.4 8065.9 8237.7 8290.7 3692.0 3841.2 4028.1 4195.7 4305.6 1898.9 2038.2 2043.9 2051.7 2085.9 881.4 1019.2 1031.9 1037.4 1041.6 18265.9 19505.0 19557.0 19577.5 20048.5 926.9 956.6 971.1 975.4 996.9 10253.3 10729.3 10921.4 10944.8 11018.4 452699.0 453520.0 455290.0 456060.0 457418.0 56197.7 75861.6 90664.5 95884.5 96596.0 980.5 993.6 1028.9 1037.5 1046.1 16183.8 16390.3 17320.7 17479.3 17577.4 38765.2 39807.0 40730.8 42910.4 44504.8 59242.7 59600.0 60454.0 60835.7 62202.0 8076.3 8122.6 8225.9 8256.8 8346.6 10937.7 12783.6 12981.4 12994.2 13417.8 11286.3 11383.7 11396.7 11470.6 11611.1 11202.7 11359.3 11368.1 11459.7 11656.6 10859.5 11171.1 11358.7 11484.4 11821.8 8158.5 8288.5 8452.5 8511.8 8890.7 9768.4 11212.5 11601.0 11874.8 11890.0 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | [#3] mootools.html Cycles:180 Average:5654.12 Median:5055.49 stddev:3203.85 (63.4%) stddev-sans-first:3197.26 05:27:03 INFO - PROCESS | 14684 | Values: 1450.7 1462.9 1595.2 1674.9 1679.3 7516.5 7728.6 8136.5 8658.1 8675.2 8040.4 8401.9 8417.9 8591.9 8631.8 2305.3 2326.6 2327.3 2341.9 2346.9 2275.8 2332.7 2337.0 2340.7 2355.8 2272.6 2273.9 2289.3 2334.6 2344.8 2290.4 2292.6 2307.8 2308.5 2311.1 2279.3 2285.4 2294.8 2297.6 2324.6 8446.4 8563.4 8589.6 8649.2 8672.5 5111.5 5223.2 5231.8 5234.2 5254.3 3217.7 3323.5 3439.2 3514.2 3518.3 1153.1 1161.6 1174.8 1179.9 1193.5 11771.7 11808.4 11850.9 11852.2 11887.2 4203.0 4370.2 4421.1 4466.8 4502.2 9933.1 9971.7 9978.7 10062.2 10090.2 5091.0 5114.8 5115.2 5118.4 5128.4 4604.1 4717.8 4749.4 4783.3 4852.3 3606.6 3700.2 3709.7 3760.6 3782.7 1148.9 1153.6 1154.5 1163.4 1171.9 939.2 940.9 941.4 949.6 957.3 5712.1 5903.5 6032.7 6058.6 6178.3 433.7 436.5 446.9 450.0 457.8 4100.9 4103.0 4117.2 4139.1 4207.2 10404.7 10641.3 10729.2 10755.5 10763.4 10600.4 10628.3 10641.6 10651.1 10657.8 7606.3 7780.2 7810.1 7908.8 8023.1 5811.6 5973.2 5994.1 6001.7 6056.9 9756.5 9797.6 9850.1 9914.2 10031.1 9823.3 9828.0 9918.4 9923.6 9946.1 7361.5 7534.3 7586.1 7681.6 7728.4 8433.3 8527.4 8539.3 8541.4 8554.0 7190.6 7360.1 7425.0 7556.2 7682.2 7181.7 7261.6 7446.4 7466.4 7728.6 6948.8 7040.6 7051.7 7063.9 7071.3 5018.7 5072.2 5080.6 5086.2 5210.9 5006.5 5048.3 5062.7 5073.2 5277.9 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | [#4] prototype.html Cycles:180 Average:4748.30 Median:5387.85 stddev:1377.42 (25.6%) stddev-sans-first:1340.76 05:27:03 INFO - PROCESS | 14684 | Values: 329.6 341.6 350.5 350.8 351.8 5338.1 5455.6 5472.2 5567.8 5567.9 5237.9 5334.5 5348.4 5354.2 5396.2 4284.4 4289.8 4310.0 4327.0 4333.5 4234.4 4248.4 4292.8 4326.1 4344.0 4242.6 4260.7 4273.4 4278.0 4278.2 4243.4 4246.9 4258.9 4272.3 4298.9 3711.1 3825.8 3830.0 3832.4 3837.2 5260.5 5262.3 5272.7 5276.7 5296.3 4831.2 4839.5 4842.5 4860.0 4863.8 5416.5 5624.5 5686.3 5690.5 5718.8 4050.7 4066.0 4086.3 4112.7 4143.2 5766.8 5802.3 5843.3 5850.7 5892.4 4133.4 4190.7 4262.1 4262.2 4279.0 4252.4 4256.4 4261.8 4266.3 4279.2 4756.7 4762.5 4816.5 4817.3 4853.2 5408.8 5656.2 5660.4 5665.8 5666.6 1391.9 1404.7 1406.8 1409.5 1411.0 950.0 965.2 976.7 987.5 995.8 5238.1 5332.4 5334.8 5358.4 5379.5 5556.5 5587.8 5609.4 5617.3 5633.4 5099.0 5206.0 5302.4 5320.6 5330.9 2932.8 2958.0 2971.5 2989.8 3000.0 5807.5 5836.6 5840.2 5846.5 5858.6 5460.9 5615.6 5640.6 5674.8 5675.9 5723.9 5759.3 5769.9 5772.8 5779.7 5443.2 5532.7 5578.8 5588.9 5789.8 5786.8 5798.2 5800.3 5813.8 5863.4 6032.5 6034.3 6060.7 6100.5 6117.7 3976.9 4093.5 4135.5 4146.2 4147.7 5766.4 5770.3 5772.2 5805.7 5887.5 5365.2 5671.3 5679.5 5687.0 5730.7 5619.4 5634.5 5653.4 5681.7 5692.8 5584.8 5602.8 5603.9 5646.9 5652.9 5461.4 5674.6 5694.2 5700.2 5702.2 5576.6 5608.2 5618.8 5620.9 5623.9 05:27:03 INFO - PROCESS | 14684 | 05:27:03 INFO - PROCESS | 14684 | [#5] yui.html Cycles:180 Average:17713.84 Median:26655.52 stddev:23512.32 (88.2%) stddev-sans-first:23543.48 05:27:03 INFO - PROCESS | 14684 | Values: 678.9 710.8 767.0 768.8 818.1 13643.8 14782.6 15075.5 15444.5 15464.2 14684.6 14752.9 14810.7 15141.9 15280.5 760.1 775.0 777.4 778.1 778.7 776.6 785.8 788.6 800.9 802.0 825.9 828.1 828.2 828.3 829.1 819.4 821.6 822.3 824.2 825.3 596.1 596.4 598.9 600.5 600.5 13576.5 13783.5 13884.7 13886.2 13886.9 13336.9 13567.4 13633.8 13690.9 13754.4 11078.1 11164.9 11207.4 11257.9 11819.0 3626.4 3635.8 3643.4 3669.9 3785.7 63102.1 63119.4 63190.0 63818.4 64829.7 10419.8 10718.6 10985.5 11018.7 11712.1 19394.2 19602.9 19826.6 19885.9 19907.8 8114.6 8191.5 8273.7 8302.6 8345.5 4254.5 4341.0 4392.2 4517.6 4544.6 3313.5 3437.0 3443.0 3482.3 3493.0 619.6 629.3 636.8 645.9 651.7 705.7 708.7 718.5 723.4 735.2 9538.6 9620.7 9627.4 9795.4 10048.9 630.9 653.9 703.3 733.9 734.1 4421.4 4639.8 4760.3 4803.6 4845.3 54037.0 81529.0 84087.6 89135.6 91115.5 51549.7 62313.1 78284.0 82076.6 83696.0 68726.0 73098.6 73353.3 74108.6 76198.6 9095.8 9287.2 9294.3 9314.5 9394.8 48465.8 48903.8 49516.8 50055.5 50937.7 66457.0 67283.0 68414.0 68721.3 68730.3 11391.4 11394.8 11508.5 11694.1 12294.3 11944.8 12440.0 13007.6 13044.7 13047.3 12035.9 12284.4 12288.8 12371.2 12547.6 11953.8 12119.2 12168.9 12575.5 13014.9 11998.3 12297.5 12317.4 12613.2 13033.6 10021.5 10076.6 10577.5 10947.3 11005.5 10296.7 10673.9 10684.9 10702.5 10842.7 05:27:03 INFO - PROCESS | 14684 | -------- Summary: end -------- 05:27:03 INFO - PROCESS | 14684 | 05:27:04 INFO - TEST-INFO | 14684: exit 0 05:27:04 INFO - TEST-OK | dromaeo_css | took 1115433ms 05:27:04 INFO - TEST-START | kraken 05:27:04 INFO - operating with platform_type : linux_ 05:27:04 INFO - Initialising browser for kraken test... 05:27:04 INFO - TEST-INFO | started process 15044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0w7De/profile http://localhost:48570/getInfo.html) 05:27:08 INFO - PROCESS | 15044 | __metrics Screen width/height:1600/1200 05:27:08 INFO - PROCESS | 15044 | colorDepth:24 05:27:08 INFO - PROCESS | 15044 | Browser inner width/height: 1024/697 05:27:08 INFO - PROCESS | 15044 | __metrics 05:27:09 ERROR - PROCESS | 15044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 05:27:10 INFO - TEST-INFO | 15044: exit 0 05:27:10 INFO - Browser initialized. 05:27:10 INFO - Running cycle 1/1 for kraken test... 05:27:10 INFO - TEST-INFO | started process 15167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0w7De/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:22 INFO - PROCESS | 15167 | RSS: Main: 185860096 05:27:22 INFO - PROCESS | 15167 | 05:27:25 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:26 INFO - PROCESS | 15167 | RSS: Main: 198352896 05:27:26 INFO - PROCESS | 15167 | 05:27:29 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-dft) 05:27:29 INFO - PROCESS | 15167 | RSS: Main: 196927488 05:27:29 INFO - PROCESS | 15167 | 05:27:32 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-fft) 05:27:33 INFO - PROCESS | 15167 | RSS: Main: 192839680 05:27:33 INFO - PROCESS | 15167 | 05:27:35 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-oscillator) 05:27:35 INFO - PROCESS | 15167 | RSS: Main: 193327104 05:27:35 INFO - PROCESS | 15167 | 05:27:38 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:38 INFO - PROCESS | 15167 | RSS: Main: 193769472 05:27:38 INFO - PROCESS | 15167 | 05:27:41 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48570/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:42 INFO - PROCESS | 15167 | RSS: Main: 193933312 05:27:42 INFO - PROCESS | 15167 | 05:27:45 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48570/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:46 INFO - PROCESS | 15167 | RSS: Main: 191881216 05:27:46 INFO - PROCESS | 15167 | 05:27:49 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48570/tests/kraken/driver.html?testName=json-parse-financial) 05:27:49 INFO - PROCESS | 15167 | RSS: Main: 193273856 05:27:49 INFO - PROCESS | 15167 | 05:27:51 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:51 INFO - PROCESS | 15167 | RSS: Main: 193683456 05:27:51 INFO - PROCESS | 15167 | 05:27:53 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:54 INFO - PROCESS | 15167 | RSS: Main: 193728512 05:27:54 INFO - PROCESS | 15167 | 05:27:56 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:57 INFO - PROCESS | 15167 | RSS: Main: 193957888 05:27:57 INFO - PROCESS | 15167 | 05:27:59 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:00 INFO - PROCESS | 15167 | RSS: Main: 194027520 05:28:00 INFO - PROCESS | 15167 | 05:28:03 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:03 INFO - PROCESS | 15167 | RSS: Main: 194043904 05:28:03 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48570/tests/kraken/driver.html?testName=ai-astar) 05:28:05 INFO - PROCESS | 15167 | RSS: Main: 195956736 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | __start_tp_report 05:28:05 INFO - PROCESS | 15167 | _x_x_mozilla_page_load 05:28:05 INFO - PROCESS | 15167 | _x_x_mozilla_page_load_details 05:28:05 INFO - PROCESS | 15167 | |i|pagename|runs| 05:28:05 INFO - PROCESS | 15167 | |0;ai-astar;105;112;113;113;112;113;114;112;113;112 05:28:05 INFO - PROCESS | 15167 | |1;audio-beat-detection;151;125;127;170;123;125;125;125;168;131 05:28:05 INFO - PROCESS | 15167 | |2;audio-dft;164;164;162;165;168;162;162;162;161;165 05:28:05 INFO - PROCESS | 15167 | |3;audio-fft;76;77;75;111;76;75;75;75;100;75 05:28:05 INFO - PROCESS | 15167 | |4;audio-oscillator;84;83;119;82;83;82;103;83;83;121 05:28:05 INFO - PROCESS | 15167 | |5;imaging-gaussian-blur;118;119;118;118;117;118;117;117;117;117 05:28:05 INFO - PROCESS | 15167 | |6;imaging-darkroom;147;145;148;146;148;147;148;145;149;147 05:28:05 INFO - PROCESS | 15167 | |7;imaging-desaturate;85;86;85;86;85;84;85;85;85;86 05:28:05 INFO - PROCESS | 15167 | |8;json-parse-financial;53;52;52;52;55;58;54;53;54;53 05:28:05 INFO - PROCESS | 15167 | |9;json-stringify-tinderbox;63;63;63;62;64;63;63;64;66;62 05:28:05 INFO - PROCESS | 15167 | |10;stanford-crypto-aes;80;82;80;80;83;84;79;83;79;81 05:28:05 INFO - PROCESS | 15167 | |11;stanford-crypto-ccm;137;135;139;138;135;137;132;131;176;141 05:28:05 INFO - PROCESS | 15167 | |12;stanford-crypto-pbkdf2;166;170;171;177;175;168;166;165;173;171 05:28:05 INFO - PROCESS | 15167 | |13;stanford-crypto-sha256-iterative;71;70;67;65;68;69;65;68;64;65 05:28:05 INFO - PROCESS | 15167 | __end_tp_report 05:28:05 INFO - PROCESS | 15167 | __start_cc_report 05:28:05 INFO - PROCESS | 15167 | _x_x_mozilla_cycle_collect,793 05:28:05 INFO - PROCESS | 15167 | __end_cc_report 05:28:05 INFO - PROCESS | 15167 | __startTimestamp1478611685917__endTimestamp 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | ------- Summary: start ------- 05:28:05 INFO - PROCESS | 15167 | Number of tests: 14 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.51 (2.2%) stddev-sans-first:0.71 05:28:05 INFO - PROCESS | 15167 | Values: 105.0 112.0 113.0 113.0 112.0 113.0 114.0 112.0 113.0 112.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:129.00 stddev:18.72 (14.5%) stddev-sans-first:19.16 05:28:05 INFO - PROCESS | 15167 | Values: 151.0 125.0 127.0 170.0 123.0 125.0 125.0 125.0 168.0 131.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 05:28:05 INFO - PROCESS | 15167 | Values: 164.0 164.0 162.0 165.0 168.0 162.0 162.0 162.0 161.0 165.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:12.93 (17.2%) stddev-sans-first:13.56 05:28:05 INFO - PROCESS | 15167 | Values: 76.0 77.0 75.0 111.0 76.0 75.0 75.0 75.0 100.0 75.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.00 stddev:15.91 (19.2%) stddev-sans-first:16.59 05:28:05 INFO - PROCESS | 15167 | Values: 84.0 83.0 119.0 82.0 83.0 82.0 103.0 83.0 83.0 121.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:28:05 INFO - PROCESS | 15167 | Values: 118.0 119.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:1.33 (0.9%) stddev-sans-first:1.41 05:28:05 INFO - PROCESS | 15167 | Values: 147.0 145.0 148.0 146.0 148.0 147.0 148.0 145.0 149.0 147.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:28:05 INFO - PROCESS | 15167 | Values: 85.0 86.0 85.0 86.0 85.0 84.0 85.0 85.0 85.0 86.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.84 (3.4%) stddev-sans-first:1.94 05:28:05 INFO - PROCESS | 15167 | Values: 53.0 52.0 52.0 52.0 55.0 58.0 54.0 53.0 54.0 53.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 05:28:05 INFO - PROCESS | 15167 | Values: 63.0 63.0 63.0 62.0 64.0 63.0 63.0 64.0 66.0 62.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.50 stddev:1.79 (2.2%) stddev-sans-first:1.86 05:28:05 INFO - PROCESS | 15167 | Values: 80.0 82.0 80.0 80.0 83.0 84.0 79.0 83.0 79.0 81.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:137.50 stddev:12.97 (9.4%) stddev-sans-first:13.71 05:28:05 INFO - PROCESS | 15167 | Values: 137.0 135.0 139.0 138.0 135.0 137.0 132.0 131.0 176.0 141.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:4.02 (2.4%) stddev-sans-first:3.97 05:28:05 INFO - PROCESS | 15167 | Values: 166.0 170.0 171.0 177.0 175.0 168.0 166.0 165.0 173.0 171.0 05:28:05 INFO - PROCESS | 15167 | 05:28:05 INFO - PROCESS | 15167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:2.39 (3.5%) stddev-sans-first:2.11 05:28:05 INFO - PROCESS | 15167 | Values: 71.0 70.0 67.0 65.0 68.0 69.0 65.0 68.0 64.0 65.0 05:28:05 INFO - PROCESS | 15167 | -------- Summary: end -------- 05:28:05 INFO - PROCESS | 15167 | 05:28:07 INFO - TEST-INFO | 15167: exit 0 05:28:07 INFO - TEST-OK | kraken | took 62407ms 05:28:07 INFO - SUITE-END | took 1177s 05:28:07 INFO - Completed test suite (00:19:38) 05:28:07 INFO - javascript benchmark 05:28:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7077.3577862632565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.7814752967292, 3139.8273094979795, 3151.023182813328, 3162.573052637894, 3174.9999999999986, 5343.625946183769, 5391.784328626855, 5452.509274165324, 5474.47992440718, 5490.368607610126, 5431.402545719968, 5433.049216387136, 5488.121900495921, 5539.113741801312, 5558.555315574755, 4889.999999999991, 4965.329680493123, 4990.975045124769, 4998.175301075336, 5094.184930411135, 5010.323606313155, 5107.46371630979, 5131.025105230013, 5138.948610513903, 5174.844754657347, 4842.055799119174, 4997.576175554853, 5038.143515602356, 5041.0422019816115, 5047.242913562958, 4869.026194761062, 4875.658703890729, 4929.6302777291485, 4941.579965702919, 5003.574696150831, 4828.46886842447, 4847.321375007502, 4848.612111031109, 4874.4150701916, 4926.014797040571, 5374.355077390699, 5378.112611419111, 5387.649802762808, 5398.757055932492, 5403.2705584745945, 5723.484886360247, 5799.18811366409, 5822.0684690449325, 5823.2138661280605, 5826.708664566755, 5834.474897259267, 5889.499392551638, 5890.676012819294, 5894.469497745181, 5903.616264942765, 5323.0152421802095, 5358.571314294847, 5462.481064298925, 5463.672179669233, 5479.863003424946, 5805.767769289181, 5832.591718579743, 5850.853728656818, 5890.941090589039, 5904.084866845646, 5625.296837895263, 5645.802396916089, 5653.321601407857, 5655.123455864265, 5661.801836935688, 5600.523955463831, 5719.714014299351, 5721.942780572224, 5730.255066841284, 5753.280839895013, 5674.858128546819, 5761.827145185567, 5810.7966221182905, 5828.184054232411, 5878.0, 5833.854153646108, 5841.912371314434, 5848.88302233953, 5865.88268234633, 5866.1494083357675, 4520.480144783326, 4526.932096018562, 4534.047849951481, 4538.931916021263, 4544.568266014723, 3935.2523020626563, 3969.364901615728, 3970.50368703912, 3991.7405368650943, 4004.2592120457807, 5554.166874968706, 5579.46995035471, 5579.581531385163, 5611.971940140274, 5612.915806262909, 5859.5019423349495, 5870.647761134345, 5881.676507792027, 5882.882342353129, 5884.676342801187, 5422.674639521641, 5505.201745746845, 5550.750216240279, 5580.581456390787, 5589.664620122806, 5062.443131255559, 5067.6452648315, 5071.746412679351, 5092.567131793765, 5093.465186155475, 6072.483838873569, 6077.088436734525, 6085.786997455068, 6086.178365920544, 6096.634201947897, 5633.183188437735, 5770.2498675171955, 5804.796832110856, 5894.528437725057, 5907.054871220584, 5880.441358070976, 6055.818325450244, 6056.6971651418135, 6071.089336599545, 6084.726187321669, 5722.74247658848, 5727.4845263926445, 5756.3380211276235, 5777.537796976148, 5785.363610002981, 5697.914531282117, 5748.5688573358, 5801.274840644919, 5874.206982057539, 5890.322612899571, 5642.435756424325, 5664.291963504562, 5669.744861481326, 5672.092465205547, 5701.059325211294, 5580.720963951868, 5652.68910209926, 5664.575156863334, 5666.716664166857, 5694.743736531949, 5523.143912693539, 5525.972370138124, 5559.33288005442, 5626.212330273683, 5631.63394379364, 5687.118496633028, 5749.942500574941, 5754.913676294943, 5801.390853960443, 5801.448862358069, 5619.072852979212, 5619.185218143428, 5626.971865140648, 5630.662160270397, 5632.662040277596], "value": 5372.339162754801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.0214228313876, 579.9416065680133, 584.0917373484233, 586.6861229242356, 613.4049971527622, 36965.0, 40208.99999999996, 40251.79874100629, 40261.19477610446, 40284.19431611366, 40536.0, 40820.38769418461, 40968.59031409685, 40974.59025409752, 40996.385054224134, 8327.417080804345, 8446.197611226955, 8453.239208471236, 8456.915430845675, 8487.872681909776, 8404.663813447485, 8424.915750842505, 8460.8730869037, 8486.0665326814, 8487.98144222691, 8546.40175187737, 8574.69988550401, 8609.225169734722, 8610.052894181636, 8628.137186281354, 8459.492430454193, 8475.830483390358, 8487.533185674785, 8548.316134709208, 8551.486910785372, 8397.6221070052, 8462.0, 8464.915350846475, 8476.576171191417, 8483.15168483153, 39569.40645890285, 39779.40330895039, 39843.8007809962, 39944.400833987514, 39989.80005099956, 3360.993581297765, 3528.400171970771, 3826.196498735269, 3858.305505009097, 4102.466679331697, 30697.539536906963, 30846.383072338653, 30997.22506937322, 31281.687183128106, 31310.21724456884, 4038.29329867275, 4117.814698338552, 4148.709590328678, 4265.893352666177, 4330.523642399365, 313074.0, 314644.0, 315301.0, 315878.0, 318247.0, 53985.730071350175, 54096.72951635216, 54160.45839541554, 54245.0, 54305.72847135739, 55342.0, 55600.44399556034, 55942.0, 56088.71955640196, 56261.43738562562, 15975.840241597667, 16376.344946202018, 16401.58996025109, 16473.093979831225, 16491.67016659684, 10606.681799546026, 10618.946905265424, 10676.199285053497, 10711.089557387553, 10739.355638661706, 15360.769588456182, 16111.27499262536, 16117.516474505783, 16153.192340382933, 16674.0, 5955.34491205967, 5984.222051133324, 5984.251968503937, 6102.542309326818, 6261.279952805486, 954.3224310739314, 959.8032403357295, 975.8877729061107, 1022.2690776095128, 1103.3931337764197, 31448.685513144577, 31571.21071973219, 31666.683333166373, 31939.840300798347, 32330.83834580812, 1032.2464600841429, 1083.766990097117, 1098.4013712526692, 1105.474899422784, 1208.3656080557778, 15647.452339168301, 16374.672506549803, 16459.753103703453, 16480.587985300222, 16714.080725560212, 486650.0, 490472.0, 493233.0, 494804.0, 495617.0, 54341.1848822268, 54738.72630636821, 54775.72612136914, 54884.725576372664, 54887.72556137194, 1303.4264923433848, 1317.5981325695564, 1326.8606796286444, 1339.9799003014768, 1348.662834291427, 29263.268418289714, 30440.39119217559, 30588.694113058584, 30971.225719357197, 31748.206294842814, 47766.5223347776, 48019.51980480151, 48100.27849582329, 48139.0, 48139.75930120467, 405283.0, 406369.0, 408262.0, 408517.0, 408673.0, 26705.599416008386, 27540.44919101647, 27642.58536122, 29049.419011619226, 38481.0, 42262.366064508446, 42732.78633606812, 42911.14177716491, 42960.35559466548, 44092.77953610211, 36918.44622330721, 37146.120989370786, 37160.07099822526, 37490.43764343482, 38922.2215555693, 36964.0, 37208.81395593005, 37531.43702844405, 37704.622953770115, 38695.0, 34830.47754283637, 35360.0, 37679.0, 38067.42898856575, 38139.42790858195, 32700.50949235716, 34982.0, 35023.64976350306, 35034.29931401409, 35496.0, 27199.72800271972, 27709.445811083264, 27713.58429623517, 27936.441271174055, 27995.58006629943], "value": 18976.44431141145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7822819221236, 390.69135383047393, 398.5556104942988, 399.3889349295577, 425.67861264745113, 13471.352816873308, 17726.822731772678, 17813.37653182139, 18868.05659717012, 18953.43139705809, 15575.454859079935, 15809.60475988101, 17048.573785655364, 19227.423177304703, 19336.0, 5548.944510554893, 5601.663900166003, 5749.252597162363, 5780.132980052984, 5838.153467747175, 5663.660180389169, 5747.2528571285675, 5771.769129234825, 5773.364929857712, 5776.653400795965, 5585.273914391123, 5618.887622247553, 5618.9604923089155, 5658.660480371191, 5748.45389687979, 5639.605227634067, 5685.687287199203, 5696.8006119785605, 5699.287589051369, 5709.971450142764, 4922.483139270361, 5068.797248110071, 5100.438951715309, 5103.9489605103845, 5107.540321371094, 20537.589248215103, 21209.5758084839, 21247.15011399542, 22746.545069098527, 22797.54404911909, 2353.9293821185393, 2385.4751954570143, 2522.545941730488, 2536.1377131775102, 3054.266975925784, 9512.47681377524, 14325.35535900887, 14618.707625847423, 14652.194129322883, 15138.545843624708, 1838.880472769279, 1883.962320753591, 1885.6700077486523, 1925.3646296722188, 1930.0735646889432, 82333.17666823375, 84514.57742711308, 86017.56991215004, 87459.12540874573, 87625.12374876233, 10827.891721082846, 10971.122310215163, 11052.226344155832, 11318.660440186808, 11584.304941703525, 12559.87440125587, 15419.691606167813, 15434.536963891102, 15502.457413990456, 15688.607784805472, 7749.302562769265, 7847.803804904923, 7963.283304502623, 8069.3544516439715, 8137.959310203411, 7936.682532698627, 7941.444098913136, 8065.919340806634, 8237.670493180205, 8290.668373265002, 3691.9815400922826, 3841.2317536492255, 4028.0796422593385, 4195.664346852305, 4305.56944305567, 1898.9145488453053, 2038.2051000109968, 2043.9080241389174, 2051.712760213571, 2085.91656333748, 881.4314766975393, 1019.1795604538418, 1031.8813336466253, 1037.4034929915179, 1041.6146025970288, 18265.908670456563, 19505.0, 19557.0, 19577.510562236057, 20048.49878753043, 926.893407258174, 956.5552018311519, 971.1259866120548, 975.4342481360794, 996.8604395384652, 10253.33353332031, 10729.302595331279, 10921.399323037309, 10944.835827462595, 11018.39398833072, 452699.0, 453520.0, 455290.0, 456060.0, 457418.0, 56197.71901140468, 75861.62069189618, 90664.54667726619, 95884.52057739667, 96596.0, 980.4607465893872, 993.5529011944653, 1028.9125424338865, 1037.5071840875676, 1046.0637729232294, 16183.81518494988, 16390.344386224417, 17320.740188896925, 17479.300827967247, 17577.384791532237, 38765.2246955065, 39807.0, 40730.79634601808, 42910.35634465423, 44504.77747611241, 59242.70378648079, 59600.0, 60454.0, 60835.69582152061, 62202.0, 8076.313513351431, 8122.593870306579, 8225.876611850706, 8256.752297431087, 8346.624401901807, 10937.726556836144, 12783.61649150527, 12981.4158362872, 12994.220346779224, 13417.798733019208, 11286.322820630789, 11383.658490245305, 11396.658100257006, 11470.598529051444, 11611.129165312805, 11202.66392008241, 11359.261647993184, 11368.090552755595, 11459.713507162054, 11656.592019279284, 10859.51132199037, 11171.106311494897, 11358.659240222807, 11484.368359740294, 11821.76356472883, 8158.469699469753, 8288.544130072903, 8452.492850428995, 8511.787205319917, 8890.73327800167, 9768.413895166314, 11212.495437705486, 11601.0, 11874.821877672015, 11890.0], "value": 9099.96775044097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.7316146512896, 1462.9487967921123, 1595.2023988005997, 1674.891132076415, 1679.3450554283825, 7516.549007059581, 7728.613569321526, 8136.511809291439, 8658.090900455456, 8675.17585829346, 8040.396970227227, 8401.873971890427, 8417.91582084179, 8591.871121933176, 8631.827363452727, 2305.296884450242, 2326.592846251903, 2327.2552783109413, 2341.906323747048, 2346.894389752465, 2275.8179345652306, 2332.650102484624, 2336.988315058431, 2340.6723058771786, 2355.7879790818824, 2272.556851413975, 2273.920412785553, 2289.2944756156685, 2334.6147885598857, 2344.847584906984, 2290.4273931517123, 2292.5644127615783, 2307.8384513084006, 2308.480591866825, 2311.133325003124, 2279.338991692407, 2285.42864283929, 2294.770522947692, 2297.5979203639295, 2324.6164382876805, 8446.366522510836, 8563.357748168912, 8589.613467393981, 8649.221570058726, 8672.479651220947, 5111.514406131411, 5223.216517522402, 5231.764570594332, 5234.214867769865, 5254.290670759437, 3217.6621454747383, 3323.4848598467274, 3439.214511304428, 3514.1566024154017, 3518.3491054155065, 1153.0717772193382, 1161.5760247509597, 1174.8472698549133, 1179.8761130081389, 1193.4569770754285, 11771.7057073573, 11808.409579520989, 11850.940745296304, 11852.170348075639, 11887.167898247126, 4203.0, 4370.169667763115, 4421.137878113737, 4466.821327146878, 4502.212112880233, 9933.106020458194, 9971.650992215238, 9978.650747223812, 10062.24533160016, 10090.192784577217, 5091.0, 5114.795408183631, 5115.232715092766, 5118.360204974379, 5128.358955130609, 4604.125216208977, 4717.8112875485285, 4749.430068391815, 4783.306420568998, 4852.272159176152, 3606.6032736398975, 3700.2229531798084, 3709.703223742094, 3760.6427389397963, 3782.678472329828, 1148.9138314626437, 1153.6020073074776, 1154.5266440759249, 1163.4473625028045, 1171.8769529199312, 939.2439086535268, 940.9440372785349, 941.4116177389132, 949.5964215208509, 957.3011701457974, 5712.0860662293835, 5903.527717782567, 6032.668203248776, 6058.575899687068, 6178.320384757763, 433.7267521461459, 436.4958472963732, 446.8659402179333, 449.98425055122914, 457.82602611007604, 4100.938485922714, 4102.979485102615, 4117.176564687014, 4139.110091330378, 4207.242696314632, 10404.68785936408, 10641.308314959502, 10729.248952573245, 10755.462226888625, 10763.408012559385, 10600.416977066336, 10628.25602207838, 10641.574337026432, 10651.147908167328, 10657.84013239802, 7606.277403646644, 7780.2219778021745, 7810.125569863192, 7908.802279943047, 8023.1174570796, 5811.622244554091, 5973.163757073926, 5994.100884867305, 6001.699915004319, 6056.939430605637, 9756.512174391393, 9797.559109840216, 9850.064243896819, 9914.206863450763, 10031.147352474829, 9823.312368134162, 9828.0, 9918.355306905029, 9923.603055877684, 9946.104850563484, 7361.484696071438, 7534.284242996907, 7586.051743532059, 7681.615919203906, 7728.420368472274, 8433.28317093054, 8527.403081784216, 8539.274161696325, 8541.444806087584, 8553.95723021381, 7190.5920842643, 7360.116785985716, 7424.96287518559, 7556.168821429528, 7682.154962954182, 7181.748638797617, 7261.6006119663925, 7446.441516886147, 7466.440016998856, 7728.613569321624, 6948.756793512202, 7040.577565346096, 7051.682674279567, 7063.929360706327, 7071.257517960746, 5018.673786203885, 5072.213806859942, 5080.568151707146, 5086.18621020635, 5210.947890521046, 5006.4743201963265, 5048.293238946624, 5062.696238225718, 5073.188289873602, 5277.894442111213], "value": 4462.056043969302, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.64351692784186, 341.6412766595075, 350.5005367351524, 350.84913487200527, 351.8152969690912, 5338.1192103303, 5455.618106732531, 5472.206530053145, 5567.805126820562, 5567.860803479915, 5237.947620523793, 5334.506338225294, 5348.438413966536, 5354.196870469432, 5396.1905714142895, 4284.400183974246, 4289.825529108452, 4309.978450107745, 4326.978365108186, 4333.501647310568, 4234.449521562193, 4248.362745588156, 4292.806823692941, 4326.134773045388, 4344.044310251739, 4242.618164365206, 4260.70175087744, 4273.358996150587, 4278.0, 4278.165757677254, 4243.405923170759, 4246.893827654318, 4258.87223383299, 4272.273713468702, 4298.903779536229, 3711.109333759905, 3825.827837747308, 3829.9617003830163, 3832.386818109117, 3837.213371258913, 5260.473952604709, 5262.289590905217, 5272.736363181864, 5276.657017293864, 5296.3379577552805, 4831.202851529493, 4839.540243676845, 4842.506109353686, 4859.975700121477, 4863.781129849165, 5416.512513873731, 5624.493795558419, 5686.265688964864, 5690.5447564194765, 5718.79984200551, 4050.696197785178, 4066.0, 4086.3053280942013, 4112.650424713903, 4143.1713657268365, 5766.826995190109, 5802.332731735863, 5843.305441421982, 5850.6782126983, 5892.440218179266, 4133.359329303963, 4190.748555086705, 4262.126264115911, 4262.190183865056, 4279.015826359955, 4252.362840306442, 4256.361545768098, 4261.765602891809, 4266.253405653998, 4279.16556271524, 4756.6908150970075, 4762.476127625959, 4816.494268101869, 4817.253325734447, 4853.247746599282, 5408.8377348679605, 5656.151577263361, 5660.405657405995, 5665.830025099253, 5666.603337766317, 1391.9095258808347, 1404.6839461121167, 1406.8452470228267, 1409.4714482069223, 1410.971780564383, 950.0309684122157, 965.1699538396973, 976.6972238606055, 987.4963768478128, 995.835687111633, 5238.114278859607, 5332.413434522199, 5334.786608535615, 5358.410574836765, 5379.515843574097, 5556.471970208225, 5587.804426845041, 5609.382967873531, 5617.269754931915, 5633.436656334334, 5098.97450512745, 5205.973970130125, 5302.416734159239, 5320.600954928396, 5330.908073317467, 2932.780041496896, 2958.0, 2971.5484725101446, 2989.8355590442734, 2999.9800067976994, 5807.5063619591965, 5836.649801011953, 5840.240768700041, 5846.532277417797, 5858.648481091148, 5460.918086228709, 5615.578831587647, 5640.605157638925, 5674.801381951612, 5675.886482270332, 5723.914141287884, 5759.280089988752, 5769.913451298234, 5772.826815195467, 5779.739911703983, 5443.230949941364, 5532.723363831873, 5578.82844602638, 5588.86027849307, 5789.8263052108505, 5786.784775197256, 5798.217240672624, 5800.303963524404, 5813.76744930198, 5863.413658634103, 6032.54755893301, 6034.306054803754, 6060.727267273071, 6100.481459076028, 6117.663528505975, 3976.880693579197, 4093.5292441369625, 4135.462389889295, 4146.1500392418875, 4147.688923330823, 5766.4233576642, 5770.278715160605, 5772.249607550992, 5805.738741756547, 5887.470127688357, 5365.22204280385, 5671.262735844314, 5679.466544033171, 5687.0, 5730.742116604846, 5619.353774315842, 5634.464725851038, 5653.3781284057895, 5681.721612637123, 5692.829215123553, 5584.776608935759, 5602.842905481501, 5603.943960560342, 5646.87062587476, 5652.858678532905, 5461.371942226695, 5674.57440691958, 5694.231278777312, 5700.201971723879, 5702.230198923258, 5576.609637325349, 5608.2148499209325, 5618.831435056954, 5620.9156862647915, 5623.88752224945], "value": 4309.223073819517, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.942289905358, 710.776105526759, 766.9846603067937, 768.7924260449679, 818.1327792539912, 13643.795343069849, 14782.630434239149, 15075.472358467456, 15444.459443919464, 15464.226788660564, 14684.559463216094, 14752.926235368835, 14810.703785924303, 15141.92429037856, 15280.465183718572, 760.0992823504151, 775.0157300228706, 777.4130531448749, 778.1012930065755, 778.715768744407, 776.6000509737489, 785.7642707187849, 788.5584072919155, 800.9239122283374, 802.0295442514536, 825.8719898415725, 828.0642873552907, 828.1759649149105, 828.2793969246763, 829.0755807274875, 819.4100247821589, 821.6425854753171, 822.2722890242179, 824.1552408781017, 825.2696363718093, 596.0998891673604, 596.3916804859062, 598.9401059894019, 600.4505877122427, 600.495583709686, 13576.524821631196, 13783.51757688476, 13884.722305553832, 13886.166829990232, 13886.93056534721, 13336.933315333457, 13567.389467473988, 13633.795493067611, 13690.93154534231, 13754.381052852646, 11078.113750899909, 11164.888351116466, 11207.383593902332, 11257.943710281477, 11819.0, 3626.4016437287814, 3635.763675361093, 3643.36241157799, 3669.87155449558, 3785.6592906638534, 63102.05346919846, 63119.36880631181, 63190.0, 63818.361816382174, 64829.67585162091, 10419.843702344471, 10718.624848130277, 10985.450727463594, 11018.724531886766, 11712.063034957184, 19394.2242310306, 19602.901985490265, 19826.60346793085, 19885.900570497055, 19907.800921990594, 8114.553699546582, 8191.467554608931, 8273.710420135387, 8302.584870756438, 8345.499270043816, 4254.510731265882, 4341.0, 4392.231359512072, 4517.593416592523, 4544.636429085665, 3313.4698448248164, 3436.9828150859585, 3442.982785086109, 3482.3209474152295, 3493.0, 619.603453789575, 629.2600958350165, 636.8407898025494, 645.9483241340681, 651.667649498759, 705.6753893209078, 708.7342246657504, 718.5006420537676, 723.3887365176417, 735.2316828913798, 9538.61845526185, 9620.663276785279, 9627.374220675634, 9795.363301385387, 10048.949755251324, 630.9337519560472, 653.8692261547709, 703.3037293079916, 733.8532293541313, 734.1190571314337, 4421.40311058003, 4639.837605683852, 4760.285957106462, 4803.605924018044, 4845.273209018605, 54037.0, 81529.0, 84087.5795621018, 89135.55432222797, 91115.54442227747, 51549.7422512885, 62313.06530402048, 78284.0, 82076.58961705153, 83696.0, 68726.0, 73098.63450682712, 73353.26646733464, 74108.62945685237, 76198.61900690461, 9095.772605684646, 9287.164155226063, 9294.25645948336, 9314.534273286445, 9394.81210375775, 48465.75767121283, 48903.75548122237, 49516.75241623769, 50055.49944500654, 50937.745311273204, 66457.0, 67283.0, 68414.0, 68721.3127868715, 68730.3126968724, 11391.373474458653, 11394.829077564009, 11508.48211830453, 11694.122940779645, 12294.323812190416, 11944.820827687417, 12440.009977550511, 13007.619275570434, 13044.673883152996, 13047.28239946774, 12035.879641203826, 12284.385780711107, 12288.754224915272, 12371.195872268274, 12547.62357129251, 11953.820692689791, 12119.151659383759, 12168.939155304166, 12575.49698012106, 13014.869851301744, 11998.280103193487, 12297.50809967627, 12317.384130793604, 12613.243205407705, 13033.608991730263, 10021.503026811823, 10076.647317343857, 10577.471126443801, 10947.288426252586, 11005.504752286326, 10296.691099267035, 10673.8932610676, 10684.89315106839, 10702.464876756287, 10842.674719758419], "value": 7044.201560397563, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 113.0, 112.0, 113.0, 114.0, 112.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 127.0, 170.0, 123.0, 125.0, 125.0, 125.0, 168.0, 131.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 165.0, 168.0, 162.0, 162.0, 162.0, 161.0, 165.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 111.0, 76.0, 75.0, 75.0, 75.0, 100.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 119.0, 82.0, 83.0, 82.0, 103.0, 83.0, 83.0, 121.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 148.0, 146.0, 148.0, 147.0, 148.0, 145.0, 149.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 84.0, 85.0, 85.0, 85.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 55.0, 58.0, 54.0, 53.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 64.0, 63.0, 63.0, 64.0, 66.0, 62.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 80.0, 80.0, 83.0, 84.0, 79.0, 83.0, 79.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 139.0, 138.0, 135.0, 137.0, 132.0, 131.0, 176.0, 141.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 171.0, 177.0, 175.0, 168.0, 166.0, 165.0, 173.0, 171.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 67.0, 65.0, 68.0, 69.0, 65.0, 68.0, 64.0, 65.0], "value": 67.2, "unit": "score"}]}]} 05:28:07 INFO - Return code: 0 05:28:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:28:07 ERROR - # TBPL SUCCESS # 05:28:07 INFO - Running post-action listener: _resource_record_post_action 05:28:07 INFO - [mozharness: 2016-11-08 13:28:07.739973Z] Finished run-tests step (success) 05:28:07 INFO - Running post-run listener: _resource_record_post_run 05:28:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393158656; Read time: 20; Write time: 307948 05:28:07 INFO - TinderboxPrint: CPU usage
13.4% 05:28:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:28:07 INFO - TinderboxPrint: I/O write bytes / time
393,158,656 / 307,948 05:28:07 INFO - TinderboxPrint: CPU idle
8,253.6 (86.6%) 05:28:07 INFO - TinderboxPrint: CPU user
1,213.3 (12.7%) 05:28:07 INFO - TinderboxPrint: Swap in / out
0 / 0 05:28:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103706624; Read time: 0; Write time: 101432 05:28:07 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289452032; Read time: 0; Write time: 206516 05:28:08 INFO - Running post-run listener: _upload_blobber_files 05:28:08 INFO - Blob upload gear active. 05:28:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:08 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 05:28:08 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'] 05:28:08 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 05:28:08 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:09 INFO - (blobuploader) - INFO - Done attempting. 05:28:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:28:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:13 INFO - (blobuploader) - INFO - Done attempting. 05:28:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:28:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:13 INFO - (blobuploader) - INFO - Done attempting. 05:28:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:13 INFO - Return code: 0 05:28:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71fb342579d0205c21a14145d37cc6abce050af029774226f3c3abce831fbc78021595ffbe84aaec2b163f617f0c820a68157d1ba0cbd776f60712f8ea787892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a49a209850481b192b1d7b92667ec2269044d0022828cb32171c70281448a9ffc3d59c3e203ff2abad56250f7ef3080601f6246da96dce45e6313220e22884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af9d4d24084a9063113e52308607462836983f45cc1a8f0ff642912c4ce27c4f7942d4447a9fa73a76edcfb12fc68c5193235f983815c563d498228f781f062"} 05:28:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:13 INFO - Contents: 05:28:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71fb342579d0205c21a14145d37cc6abce050af029774226f3c3abce831fbc78021595ffbe84aaec2b163f617f0c820a68157d1ba0cbd776f60712f8ea787892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a49a209850481b192b1d7b92667ec2269044d0022828cb32171c70281448a9ffc3d59c3e203ff2abad56250f7ef3080601f6246da96dce45e6313220e22884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af9d4d24084a9063113e52308607462836983f45cc1a8f0ff642912c4ce27c4f7942d4447a9fa73a76edcfb12fc68c5193235f983815c563d498228f781f062"} 05:28:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:13 INFO - Copying logs to upload dir... 05:28:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.300391 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-08 05:28:13.731639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 05:28:13.735558) ========= 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=826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71fb342579d0205c21a14145d37cc6abce050af029774226f3c3abce831fbc78021595ffbe84aaec2b163f617f0c820a68157d1ba0cbd776f60712f8ea787892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a49a209850481b192b1d7b92667ec2269044d0022828cb32171c70281448a9ffc3d59c3e203ff2abad56250f7ef3080601f6246da96dce45e6313220e22884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af9d4d24084a9063113e52308607462836983f45cc1a8f0ff642912c4ce27c4f7942d4447a9fa73a76edcfb12fc68c5193235f983815c563d498228f781f062"} build_url:https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71fb342579d0205c21a14145d37cc6abce050af029774226f3c3abce831fbc78021595ffbe84aaec2b163f617f0c820a68157d1ba0cbd776f60712f8ea787892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a49a209850481b192b1d7b92667ec2269044d0022828cb32171c70281448a9ffc3d59c3e203ff2abad56250f7ef3080601f6246da96dce45e6313220e22884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af9d4d24084a9063113e52308607462836983f45cc1a8f0ff642912c4ce27c4f7942d4447a9fa73a76edcfb12fc68c5193235f983815c563d498228f781f062"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 05:28:13.761189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:28:13.761564) ========= 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=826874ccc97bd7bf541b4875000001d5-1478610449.681776-1272429401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:28:13.846373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 05:28:13.846729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 05:28:13.847049) ========= ========= Total master_lag: 0.17 =========