builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1478279654.45 results: success (0) buildid: 20161104073159 builduid: 94e17d544015401f8496e86dc9697cce revision: 9c6b3b3a119bc48f5d12e3161218e98adaa12627 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.448206) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.448961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.449458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.474700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.475172) ========= 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=32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-04 10:14:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-11-04 10:14:14 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.633662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.634044) ========= 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=32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018351 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.685691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:14.686127) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9c6b3b3a119bc48f5d12e3161218e98adaa12627 --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 9c6b3b3a119bc48f5d12e3161218e98adaa12627 --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=32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-04 10:14:15,033 truncating revision to first 12 chars 2016-11-04 10:14:15,033 Setting DEBUG logging. 2016-11-04 10:14:15,034 attempt 1/10 2016-11-04 10:14:15,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9c6b3b3a119b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 10:14:15,339 unpacking tar archive at: mozilla-central-9c6b3b3a119b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641947 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:15.343287) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:15.343684) ========= script_repo_revision: 9c6b3b3a119bc48f5d12e3161218e98adaa12627 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:15.344121) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:15.344492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 10:14:15.354564) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-04 10:14:15.354902) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:15 INFO - MultiFileLogger online at 20161104 10:14:15 in /builds/slave/test 10:14:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:14:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:15 INFO - {'append_to_log': False, 10:14:15 INFO - 'base_work_dir': '/builds/slave/test', 10:14:15 INFO - 'blob_upload_branch': 'Firefox', 10:14:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:15 INFO - 'branch': 'Firefox', 10:14:15 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:15 INFO - 'config_files': ('talos/linux_config.py',), 10:14:15 INFO - 'default_actions': ('clobber', 10:14:15 INFO - 'read-buildbot-config', 10:14:15 INFO - 'download-and-extract', 10:14:15 INFO - 'populate-webroot', 10:14:15 INFO - 'create-virtualenv', 10:14:15 INFO - 'install', 10:14:15 INFO - 'run-tests'), 10:14:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:15 INFO - 'download_minidump_stackwalk': True, 10:14:15 INFO - 'download_symbols': 'ondemand', 10:14:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:15 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:15 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:15 INFO - 'installer_path': 'installer.exe', 10:14:15 INFO - 'log_level': 'info', 10:14:15 INFO - 'log_name': 'talos', 10:14:15 INFO - 'log_to_console': True, 10:14:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:15 INFO - 'opt_config_files': (), 10:14:15 INFO - 'pip_index': False, 10:14:15 INFO - 'sps_profile': False, 10:14:15 INFO - 'sps_profile_interval': 0, 10:14:15 INFO - 'suite': 'dromaeojs', 10:14:15 INFO - 'system_bits': '32', 10:14:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:15 INFO - 'title': 'talos-linux64-ix-008', 10:14:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:15 INFO - 'use_talos_json': True, 10:14:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:15 INFO - 'work_dir': 'build'} 10:14:15 INFO - [mozharness: 2016-11-04 17:14:15.877698Z] Running clobber step. 10:14:15 INFO - Running pre-action listener: _resource_record_pre_action 10:14:15 INFO - Running main action method: clobber 10:14:15 INFO - rmtree: /builds/slave/test/build 10:14:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:16 INFO - Running post-action listener: _resource_record_post_action 10:14:16 INFO - [mozharness: 2016-11-04 17:14:16.299999Z] Finished clobber step (success) 10:14:16 INFO - [mozharness: 2016-11-04 17:14:16.300100Z] Running read-buildbot-config step. 10:14:16 INFO - Running pre-action listener: _resource_record_pre_action 10:14:16 INFO - Running main action method: read_buildbot_config 10:14:16 INFO - Using buildbot properties: 10:14:16 INFO - { 10:14:16 INFO - "project": "", 10:14:16 INFO - "product": "firefox", 10:14:16 INFO - "script_repo_revision": "production", 10:14:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:14:16 INFO - "repository": "", 10:14:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:14:16 INFO - "buildid": "20161104073159", 10:14:16 INFO - "pgo_build": "True", 10:14:16 INFO - "basedir": "/builds/slave/test", 10:14:16 INFO - "buildnumber": 60, 10:14:16 INFO - "slavename": "talos-linux64-ix-008", 10:14:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:14:16 INFO - "platform": "ubuntu64_hw", 10:14:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:14:16 INFO - "branch": "mozilla-central", 10:14:16 INFO - "repo_path": "mozilla-central", 10:14:16 INFO - "revision": "9c6b3b3a119bc48f5d12e3161218e98adaa12627", 10:14:16 INFO - "stage_platform": "linux64-pgo", 10:14:16 INFO - "builduid": "94e17d544015401f8496e86dc9697cce", 10:14:16 INFO - "slavebuilddir": "test" 10:14:16 INFO - } 10:14:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:14:16 INFO - Running post-action listener: _resource_record_post_action 10:14:16 INFO - [mozharness: 2016-11-04 17:14:16.302572Z] Finished read-buildbot-config step (success) 10:14:16 INFO - [mozharness: 2016-11-04 17:14:16.302662Z] Running download-and-extract step. 10:14:16 INFO - Running pre-action listener: _resource_record_pre_action 10:14:16 INFO - Running main action method: download_and_extract 10:14:16 INFO - mkdir: /builds/slave/test/build/tests 10:14:16 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')]} 10:14:16 INFO - trying https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:14:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:14:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:14:16 INFO - Downloaded 1361 bytes. 10:14:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:14:16 INFO - Using the following test package requirements: 10:14:16 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:16 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:16 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:14:16 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'jsshell-linux-x86_64.zip'], 10:14:16 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:16 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:16 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:14:16 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:14:16 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:16 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:14:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:14:17 INFO - Http code: 200 10:14:17 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 10:14:17 INFO - x-amz-cf-id: au4Bsn2m0cfy3x0PtfPW2zRVbvbuny5ghrPWNtX4-rL3tRvM4Yb-Ug== 10:14:17 INFO - x-amz-version-id: w.EfzTItHQdCai1sMLngSPfKdgjSvBGW 10:14:17 INFO - Expected file size: 22010670 10:14:17 INFO - Obtained file size: 22010670 10:14:21 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 10:14:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:14:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:14:22 INFO - Http code: 200 10:14:22 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 10:14:22 INFO - x-amz-cf-id: 54OjzX7HSt2kBNW0fjMbAeyTxolmrpcw5PONkd-wT_FzxBKBLAIU0A== 10:14:22 INFO - x-amz-version-id: w.EfzTItHQdCai1sMLngSPfKdgjSvBGW 10:14:22 INFO - Expected file size: 22010670 10:14:22 INFO - Obtained file size: 22010670 10:14:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:14:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:14:28 INFO - Http code: 200 10:14:28 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 10:14:28 INFO - x-amz-cf-id: Yg978xvDVuE0TmjEn3OcQ980j4Ym3kLb0_Xjiv9karjOae-zT2jKAQ== 10:14:28 INFO - x-amz-version-id: Sve.d4bqa9cgucr8bEoqg7CFnRXLb5VC 10:14:28 INFO - Expected file size: 14409038 10:14:28 INFO - Obtained file size: 14409038 10:14: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')]} 10:14:29 INFO - trying https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:14:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:14:31 INFO - Downloaded 59635369 bytes. 10:14:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:14:31 INFO - mkdir: /builds/slave/test/properties 10:14:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:31 INFO - Contents: 10:14:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:14:32 INFO - Running post-action listener: _resource_record_post_action 10:14:32 INFO - Running post-action listener: set_extra_try_arguments 10:14:32 INFO - [mozharness: 2016-11-04 17:14:32.021193Z] Finished download-and-extract step (success) 10:14:32 INFO - [mozharness: 2016-11-04 17:14:32.021462Z] Running populate-webroot step. 10:14:32 INFO - Running pre-action listener: _resource_record_pre_action 10:14:32 INFO - Running main action method: populate_webroot 10:14:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:32 INFO - '--tppagecycles', 10:14:32 INFO - '7'], 10:14:32 INFO - 'tests': ['tsvgm']}}, 10:14:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['damp', 'tps']}, 10:14:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'tests': ['damp', 'tps']}, 10:14:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['dromaeo_dom']}, 10:14:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['basic_compositor_video']}, 10:14:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:14:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['a11yr', 10:14:32 INFO - 'ts_paint', 10:14:32 INFO - 'tpaint', 10:14:32 INFO - 'sessionrestore', 10:14:32 INFO - 'sessionrestore_no_auto_restore', 10:14:32 INFO - 'tabpaint']}, 10:14:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:32 INFO - 'ts_paint', 10:14:32 INFO - 'tpaint', 10:14:32 INFO - 'sessionrestore', 10:14:32 INFO - 'sessionrestore_no_auto_restore', 10:14:32 INFO - 'tabpaint']}, 10:14:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:32 INFO - 'ts_paint', 10:14:32 INFO - 'tpaint', 10:14:32 INFO - 'sessionrestore', 10:14:32 INFO - 'sessionrestore_no_auto_restore', 10:14:32 INFO - 'tabpaint']}, 10:14:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:32 INFO - 'ts_paint', 10:14:32 INFO - 'tpaint', 10:14:32 INFO - 'sessionrestore', 10:14:32 INFO - 'sessionrestore_no_auto_restore', 10:14:32 INFO - 'tabpaint']}, 10:14:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['a11yr', 10:14:32 INFO - 'ts_paint', 10:14:32 INFO - 'tpaint', 10:14:32 INFO - 'sessionrestore', 10:14:32 INFO - 'sessionrestore_no_auto_restore', 10:14:32 INFO - 'tabpaint']}, 10:14:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['a11yr', 10:14:32 INFO - 'ts_paint', 10:14:32 INFO - 'tpaint', 10:14:32 INFO - 'sessionrestore', 10:14:32 INFO - 'sessionrestore_no_auto_restore', 10:14:32 INFO - 'tabpaint']}, 10:14:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['tsvgx', 10:14:32 INFO - 'tsvgr_opacity', 10:14:32 INFO - 'tart', 10:14:32 INFO - 'tscrollx', 10:14:32 INFO - 'cart']}, 10:14:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:32 INFO - 'tsvgr_opacity', 10:14:32 INFO - 'tart', 10:14:32 INFO - 'tscrollx', 10:14:32 INFO - 'cart']}, 10:14:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'talos_options': ['--disable-e10s'], 10:14:32 INFO - 'tests': ['tp5o']}, 10:14:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'tests': ['tp5o']}, 10:14:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'talos_options': ['--disable-e10s', 10:14:32 INFO - '--xperf_path', 10:14:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:32 INFO - 'tests': ['tp5n']}, 10:14:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:32 INFO - 'talos_options': ['--xperf_path', 10:14:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:32 INFO - 'tests': ['tp5n']}}, 10:14:32 INFO - 'talos.zip': {'path': '', 10:14:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:32 INFO - Running post-action listener: _resource_record_post_action 10:14:32 INFO - [mozharness: 2016-11-04 17:14:32.037707Z] Finished populate-webroot step (success) 10:14:32 INFO - [mozharness: 2016-11-04 17:14:32.037796Z] Running create-virtualenv step. 10:14:32 INFO - Running pre-action listener: _resource_record_pre_action 10:14:32 INFO - Running main action method: create_virtualenv 10:14:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:32 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 10:14:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:32 INFO - Using real prefix '/usr' 10:14:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:36 INFO - Installing pip.................done. 10:14:36 INFO - Return code: 0 10:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:14:36 INFO - Reading from file tmpfile_stdout 10:14:36 INFO - Output received: 10:14:36 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) 10:14:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14:36 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')]} 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 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')]} 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:36 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 10:14:36 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 10:14:36 INFO - Using env: {'DISPLAY': ':0', 10:14:36 INFO - 'HOME': '/home/cltbld', 10:14:36 INFO - 'LANG': 'en_US.UTF-8', 10:14:36 INFO - 'LANGUAGE': 'en_US:en', 10:14:36 INFO - 'LOGNAME': 'cltbld', 10:14:36 INFO - 'MAIL': '/var/mail/cltbld', 10:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:36 INFO - 'MOZ_NO_REMOTE': '1', 10:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:36 INFO - 'NO_EM_RESTART': '1', 10:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:36 INFO - 'PWD': '/builds/slave/test', 10:14:36 INFO - 'SHELL': '/bin/bash', 10:14:36 INFO - 'SHLVL': '1', 10:14:36 INFO - 'TERM': 'linux', 10:14:36 INFO - 'TMOUT': '86400', 10:14:36 INFO - 'USER': 'cltbld', 10:14:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:36 INFO - '_': '/tools/buildbot/bin/python'} 10:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:36 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 10:14:36 INFO - Cleaning up... 10:14:36 INFO - Return code: 0 10:14:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:36 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')]} 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 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')]} 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:36 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 10:14:36 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 10:14:36 INFO - Using env: {'DISPLAY': ':0', 10:14:36 INFO - 'HOME': '/home/cltbld', 10:14:36 INFO - 'LANG': 'en_US.UTF-8', 10:14:36 INFO - 'LANGUAGE': 'en_US:en', 10:14:36 INFO - 'LOGNAME': 'cltbld', 10:14:36 INFO - 'MAIL': '/var/mail/cltbld', 10:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:36 INFO - 'MOZ_NO_REMOTE': '1', 10:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:36 INFO - 'NO_EM_RESTART': '1', 10:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:36 INFO - 'PWD': '/builds/slave/test', 10:14:36 INFO - 'SHELL': '/bin/bash', 10:14:36 INFO - 'SHLVL': '1', 10:14:36 INFO - 'TERM': 'linux', 10:14:36 INFO - 'TMOUT': '86400', 10:14:36 INFO - 'USER': 'cltbld', 10:14:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:36 INFO - '_': '/tools/buildbot/bin/python'} 10:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:36 INFO - Downloading/unpacking psutil>=3.1.1 10:14:36 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 10:14:36 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 10:14:36 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 10:14:36 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 10:14:36 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 10:14:36 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 10:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:38 INFO - Installing collected packages: psutil 10:14:38 INFO - Running setup.py install for psutil 10:14:38 INFO - building 'psutil._psutil_linux' extension 10:14:38 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 10:14:40 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 10:14:40 INFO - building 'psutil._psutil_posix' extension 10:14:40 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 10:14:40 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 10:14:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:40 INFO - Successfully installed psutil 10:14:40 INFO - Cleaning up... 10:14:40 INFO - Return code: 0 10:14:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:40 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:40 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 10:14:40 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 10:14:40 INFO - Using env: {'DISPLAY': ':0', 10:14:40 INFO - 'HOME': '/home/cltbld', 10:14:40 INFO - 'LANG': 'en_US.UTF-8', 10:14:40 INFO - 'LANGUAGE': 'en_US:en', 10:14:40 INFO - 'LOGNAME': 'cltbld', 10:14:40 INFO - 'MAIL': '/var/mail/cltbld', 10:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:40 INFO - 'MOZ_NO_REMOTE': '1', 10:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:40 INFO - 'NO_EM_RESTART': '1', 10:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:40 INFO - 'PWD': '/builds/slave/test', 10:14:40 INFO - 'SHELL': '/bin/bash', 10:14:40 INFO - 'SHLVL': '1', 10:14:40 INFO - 'TERM': 'linux', 10:14:40 INFO - 'TMOUT': '86400', 10:14:40 INFO - 'USER': 'cltbld', 10:14:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:40 INFO - '_': '/tools/buildbot/bin/python'} 10:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:42 INFO - Installing collected packages: mozsystemmonitor 10:14:42 INFO - Running setup.py install for mozsystemmonitor 10:14:42 INFO - Successfully installed mozsystemmonitor 10:14:42 INFO - Cleaning up... 10:14:42 INFO - Return code: 0 10:14:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:14:42 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')]} 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:42 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')]} 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:43 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:43 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 10:14:43 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 10:14:43 INFO - Using env: {'DISPLAY': ':0', 10:14:43 INFO - 'HOME': '/home/cltbld', 10:14:43 INFO - 'LANG': 'en_US.UTF-8', 10:14:43 INFO - 'LANGUAGE': 'en_US:en', 10:14:43 INFO - 'LOGNAME': 'cltbld', 10:14:43 INFO - 'MAIL': '/var/mail/cltbld', 10:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:43 INFO - 'MOZ_NO_REMOTE': '1', 10:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:43 INFO - 'NO_EM_RESTART': '1', 10:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:43 INFO - 'PWD': '/builds/slave/test', 10:14:43 INFO - 'SHELL': '/bin/bash', 10:14:43 INFO - 'SHLVL': '1', 10:14:43 INFO - 'TERM': 'linux', 10:14:43 INFO - 'TMOUT': '86400', 10:14:43 INFO - 'USER': 'cltbld', 10:14:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:43 INFO - '_': '/tools/buildbot/bin/python'} 10:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:43 INFO - Downloading/unpacking jsonschema==2.5.1 10:14:43 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 10:14:43 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 10:14:43 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 10:14:43 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 10:14:43 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 10:14:43 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 10:14:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:45 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:45 INFO - warning: no files found matching '*.txt' 10:14:45 INFO - no previously-included directories found matching 'build' 10:14:45 INFO - no previously-included directories found matching 'dist' 10:14:45 INFO - no previously-included directories found matching '.git*' 10:14:45 INFO - Installing collected packages: jsonschema, functools32 10:14:45 INFO - Running setup.py install for functools32 10:14:45 INFO - warning: no files found matching '*.txt' 10:14:45 INFO - no previously-included directories found matching 'build' 10:14:45 INFO - no previously-included directories found matching 'dist' 10:14:45 INFO - no previously-included directories found matching '.git*' 10:14:45 INFO - Successfully installed jsonschema functools32 10:14:45 INFO - Cleaning up... 10:14:45 INFO - Return code: 0 10:14:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:14:45 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')]} 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:45 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')]} 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:45 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:45 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 10:14:45 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 10:14:45 INFO - Using env: {'DISPLAY': ':0', 10:14:45 INFO - 'HOME': '/home/cltbld', 10:14:45 INFO - 'LANG': 'en_US.UTF-8', 10:14:45 INFO - 'LANGUAGE': 'en_US:en', 10:14:45 INFO - 'LOGNAME': 'cltbld', 10:14:45 INFO - 'MAIL': '/var/mail/cltbld', 10:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:45 INFO - 'MOZ_NO_REMOTE': '1', 10:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:45 INFO - 'NO_EM_RESTART': '1', 10:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:45 INFO - 'PWD': '/builds/slave/test', 10:14:45 INFO - 'SHELL': '/bin/bash', 10:14:45 INFO - 'SHLVL': '1', 10:14:45 INFO - 'TERM': 'linux', 10:14:45 INFO - 'TMOUT': '86400', 10:14:45 INFO - 'USER': 'cltbld', 10:14:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:45 INFO - '_': '/tools/buildbot/bin/python'} 10:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:14:45 INFO - Cleaning up... 10:14:45 INFO - Return code: 0 10:14:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:45 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')]} 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:45 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')]} 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:45 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:45 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 10:14:45 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 10:14:45 INFO - Using env: {'DISPLAY': ':0', 10:14:45 INFO - 'HOME': '/home/cltbld', 10:14:45 INFO - 'LANG': 'en_US.UTF-8', 10:14:45 INFO - 'LANGUAGE': 'en_US:en', 10:14:45 INFO - 'LOGNAME': 'cltbld', 10:14:45 INFO - 'MAIL': '/var/mail/cltbld', 10:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:45 INFO - 'MOZ_NO_REMOTE': '1', 10:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:45 INFO - 'NO_EM_RESTART': '1', 10:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:45 INFO - 'PWD': '/builds/slave/test', 10:14:45 INFO - 'SHELL': '/bin/bash', 10:14:45 INFO - 'SHLVL': '1', 10:14:45 INFO - 'TERM': 'linux', 10:14:45 INFO - 'TMOUT': '86400', 10:14:45 INFO - 'USER': 'cltbld', 10:14:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:45 INFO - '_': '/tools/buildbot/bin/python'} 10:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 INFO - Downloading docopt-0.6.1.tar.gz 10:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:48 INFO - Running setup.py install for blobuploader 10:14:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:48 INFO - Running setup.py install for requests 10:14:49 INFO - Running setup.py install for docopt 10:14:49 INFO - Successfully installed blobuploader requests docopt 10:14:49 INFO - Cleaning up... 10:14:49 INFO - Return code: 0 10:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:49 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 10:14:49 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 10:14:49 INFO - Using env: {'DISPLAY': ':0', 10:14:49 INFO - 'HOME': '/home/cltbld', 10:14:49 INFO - 'LANG': 'en_US.UTF-8', 10:14:49 INFO - 'LANGUAGE': 'en_US:en', 10:14:49 INFO - 'LOGNAME': 'cltbld', 10:14:49 INFO - 'MAIL': '/var/mail/cltbld', 10:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:49 INFO - 'MOZ_NO_REMOTE': '1', 10:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:49 INFO - 'NO_EM_RESTART': '1', 10:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:49 INFO - 'PWD': '/builds/slave/test', 10:14:49 INFO - 'SHELL': '/bin/bash', 10:14:49 INFO - 'SHLVL': '1', 10:14:49 INFO - 'TERM': 'linux', 10:14:49 INFO - 'TMOUT': '86400', 10:14:49 INFO - 'USER': 'cltbld', 10:14:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:49 INFO - '_': '/tools/buildbot/bin/python'} 10:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:49 INFO - Running setup.py (path:/tmp/pip-Tw8XVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:49 INFO - Running setup.py (path:/tmp/pip-s6SCsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:49 INFO - Running setup.py (path:/tmp/pip-_Q5WhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:49 INFO - Running setup.py (path:/tmp/pip-9_bL54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:49 INFO - Running setup.py (path:/tmp/pip-dhfRF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:50 INFO - Running setup.py (path:/tmp/pip-d3IKnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:50 INFO - Running setup.py (path:/tmp/pip-JrdOZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:50 INFO - Running setup.py (path:/tmp/pip-noI3iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:50 INFO - Running setup.py (path:/tmp/pip-LZsGgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:50 INFO - Running setup.py (path:/tmp/pip-of2o0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:50 INFO - Running setup.py (path:/tmp/pip-ROKGST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:50 INFO - Running setup.py (path:/tmp/pip-3yQOzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:50 INFO - Running setup.py (path:/tmp/pip-nTypLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:50 INFO - Running setup.py (path:/tmp/pip-eQvg8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:50 INFO - Running setup.py (path:/tmp/pip-DjE7qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:50 INFO - Running setup.py (path:/tmp/pip-i9G31o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:50 INFO - Running setup.py (path:/tmp/pip-UKe2uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:50 INFO - Running setup.py install for manifestparser 10:14:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:50 INFO - Running setup.py install for mozcrash 10:14:51 INFO - Running setup.py install for mozdebug 10:14:51 INFO - Running setup.py install for mozdevice 10:14:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Running setup.py install for mozfile 10:14:51 INFO - Running setup.py install for mozhttpd 10:14:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Running setup.py install for mozinfo 10:14:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Running setup.py install for mozInstall 10:14:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Running setup.py install for mozleak 10:14:51 INFO - Running setup.py install for mozlog 10:14:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Running setup.py install for moznetwork 10:14:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:51 INFO - Running setup.py install for mozprocess 10:14:52 INFO - Running setup.py install for mozprofile 10:14:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:52 INFO - Running setup.py install for mozrunner 10:14:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:52 INFO - Running setup.py install for mozscreenshot 10:14:52 INFO - Running setup.py install for moztest 10:14:52 INFO - Running setup.py install for mozversion 10:14:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:52 INFO - Cleaning up... 10:14:52 INFO - Return code: 0 10:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:52 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')]} 10:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:52 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')]} 10:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:52 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:52 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 10:14:52 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 10:14:52 INFO - Using env: {'DISPLAY': ':0', 10:14:52 INFO - 'HOME': '/home/cltbld', 10:14:52 INFO - 'LANG': 'en_US.UTF-8', 10:14:52 INFO - 'LANGUAGE': 'en_US:en', 10:14:52 INFO - 'LOGNAME': 'cltbld', 10:14:52 INFO - 'MAIL': '/var/mail/cltbld', 10:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:52 INFO - 'MOZ_NO_REMOTE': '1', 10:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:52 INFO - 'NO_EM_RESTART': '1', 10:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:52 INFO - 'PWD': '/builds/slave/test', 10:14:52 INFO - 'SHELL': '/bin/bash', 10:14:52 INFO - 'SHLVL': '1', 10:14:52 INFO - 'TERM': 'linux', 10:14:52 INFO - 'TMOUT': '86400', 10:14:52 INFO - 'USER': 'cltbld', 10:14:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:52 INFO - '_': '/tools/buildbot/bin/python'} 10:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:52 INFO - Running setup.py (path:/tmp/pip-cGKTPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:52 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)) 10:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:52 INFO - Running setup.py (path:/tmp/pip-idimKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:53 INFO - Running setup.py (path:/tmp/pip-MtaU0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:53 INFO - Running setup.py (path:/tmp/pip-6vkGi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:53 INFO - Running setup.py (path:/tmp/pip-Xy3M8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:53 INFO - Running setup.py (path:/tmp/pip-MbjAk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:53 INFO - Running setup.py (path:/tmp/pip-hizIyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:53 INFO - Running setup.py (path:/tmp/pip-AWhXJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:53 INFO - Running setup.py (path:/tmp/pip-dmKgDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:53 INFO - Running setup.py (path:/tmp/pip-7a1QDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:53 INFO - Running setup.py (path:/tmp/pip-49SJNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:53 INFO - Running setup.py (path:/tmp/pip-J1IzRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:53 INFO - Running setup.py (path:/tmp/pip-Rky1z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:53 INFO - Running setup.py (path:/tmp/pip-WdAsr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:53 INFO - Running setup.py (path:/tmp/pip-rf62Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:53 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)) 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:53 INFO - Running setup.py (path:/tmp/pip-6Tz3uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:54 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)) 10:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:54 INFO - Running setup.py (path:/tmp/pip-O0X5PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:54 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)) 10:14:54 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)) 10:14:54 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)) 10:14:54 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)) 10:14:54 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)) 10:14:54 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)) 10:14:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:56 INFO - Downloading blessings-1.6.tar.gz 10:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:56 INFO - Installing collected packages: blessings 10:14:56 INFO - Running setup.py install for blessings 10:14:56 INFO - Successfully installed blessings 10:14:56 INFO - Cleaning up... 10:14:56 INFO - Return code: 0 10:14:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:56 INFO - Reading from file tmpfile_stdout 10:14:56 INFO - Current package versions: 10:14:56 INFO - argparse == 1.2.1 10:14:56 INFO - blessings == 1.6 10:14:56 INFO - blobuploader == 1.2.4 10:14:56 INFO - docopt == 0.6.1 10:14:56 INFO - functools32 == 3.2.3-2 10:14:56 INFO - jsonschema == 2.5.1 10:14:56 INFO - manifestparser == 1.1 10:14:56 INFO - mozInstall == 1.12 10:14:56 INFO - mozcrash == 0.17 10:14:56 INFO - mozdebug == 0.1 10:14:56 INFO - mozdevice == 0.48 10:14:56 INFO - mozfile == 1.2 10:14:56 INFO - mozhttpd == 0.7 10:14:56 INFO - mozinfo == 0.9 10:14:56 INFO - mozleak == 0.1 10:14:56 INFO - mozlog == 3.4 10:14:56 INFO - moznetwork == 0.27 10:14:56 INFO - mozprocess == 0.23 10:14:56 INFO - mozprofile == 0.28 10:14:56 INFO - mozrunner == 6.12 10:14:56 INFO - mozscreenshot == 0.1 10:14:56 INFO - mozsystemmonitor == 0.3 10:14:56 INFO - moztest == 0.7 10:14:56 INFO - mozversion == 1.4 10:14:56 INFO - psutil == 3.1.1 10:14:56 INFO - requests == 1.2.3 10:14:56 INFO - wsgiref == 0.1.2 10:14:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:56 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 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14:56 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 10:14:56 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 10:14:56 INFO - Using env: {'DISPLAY': ':0', 10:14:56 INFO - 'HOME': '/home/cltbld', 10:14:56 INFO - 'LANG': 'en_US.UTF-8', 10:14:56 INFO - 'LANGUAGE': 'en_US:en', 10:14:56 INFO - 'LOGNAME': 'cltbld', 10:14:56 INFO - 'MAIL': '/var/mail/cltbld', 10:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:56 INFO - 'MOZ_NO_REMOTE': '1', 10:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:56 INFO - 'NO_EM_RESTART': '1', 10:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:56 INFO - 'PWD': '/builds/slave/test', 10:14:56 INFO - 'SHELL': '/bin/bash', 10:14:56 INFO - 'SHLVL': '1', 10:14:56 INFO - 'TERM': 'linux', 10:14:56 INFO - 'TMOUT': '86400', 10:14:56 INFO - 'USER': 'cltbld', 10:14:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:56 INFO - '_': '/tools/buildbot/bin/python'} 10:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 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)) 10:14:56 INFO - Cleaning up... 10:14:56 INFO - Return code: 0 10:14:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd597a5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2004790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', '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 10:14: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'] in /builds/slave/test/build 10:14: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 10:14:56 INFO - Using env: {'DISPLAY': ':0', 10:14:56 INFO - 'HOME': '/home/cltbld', 10:14:56 INFO - 'LANG': 'en_US.UTF-8', 10:14:56 INFO - 'LANGUAGE': 'en_US:en', 10:14:56 INFO - 'LOGNAME': 'cltbld', 10:14:56 INFO - 'MAIL': '/var/mail/cltbld', 10:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:56 INFO - 'MOZ_NO_REMOTE': '1', 10:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:56 INFO - 'NO_EM_RESTART': '1', 10:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:56 INFO - 'PWD': '/builds/slave/test', 10:14:56 INFO - 'SHELL': '/bin/bash', 10:14:56 INFO - 'SHLVL': '1', 10:14:56 INFO - 'TERM': 'linux', 10:14:56 INFO - 'TMOUT': '86400', 10:14:56 INFO - 'USER': 'cltbld', 10:14:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:56 INFO - '_': '/tools/buildbot/bin/python'} 10:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:14:56 INFO - Cleaning up... 10:14:57 INFO - Return code: 0 10:14:57 INFO - Running post-action listener: _resource_record_post_action 10:14:57 INFO - Running post-action listener: _start_resource_monitoring 10:14:57 INFO - Starting resource monitoring. 10:14:57 INFO - [mozharness: 2016-11-04 17:14:57.046946Z] Finished create-virtualenv step (success) 10:14:57 INFO - [mozharness: 2016-11-04 17:14:57.047393Z] Running install step. 10:14:57 INFO - Running pre-action listener: _resource_record_pre_action 10:14:57 INFO - Running main action method: install 10:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:57 INFO - Reading from file tmpfile_stdout 10:14:57 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:57 INFO - Reading from file tmpfile_stdout 10:14:57 INFO - Output received: 10:14:57 INFO - Usage: mozinstall [options] installer 10:14:57 INFO - Options: 10:14:57 INFO - -h, --help show this help message and exit 10:14:57 INFO - -d DEST, --destination=DEST 10:14:57 INFO - Directory to install application into. [default: 10:14:57 INFO - "/builds/slave/test"] 10:14:57 INFO - --app=APP Application being installed. [default: firefox] 10:14:57 INFO - mkdir: /builds/slave/test/build/application 10:14:57 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'] 10:14:57 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 10:15:14 INFO - Reading from file tmpfile_stdout 10:15:14 INFO - Output received: 10:15:14 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:14 INFO - Running post-action listener: _resource_record_post_action 10:15:14 INFO - [mozharness: 2016-11-04 17:15:14.302346Z] Finished install step (success) 10:15:14 INFO - [mozharness: 2016-11-04 17:15:14.302591Z] Running run-tests step. 10:15:14 INFO - Running pre-action listener: _resource_record_pre_action 10:15:14 INFO - Running main action method: run_tests 10:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:14 INFO - Python 2.7.3 10:15:14 INFO - Return code: 0 10:15:14 INFO - grabbing minidump binary from tooltool 10:15:14 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')]} 10:15:14 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 0x2001930>, '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 0x2002830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2002cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:14 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 10:15:14 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 10:15:14 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 10:15:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:14 INFO - Return code: 0 10:15:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:15:14 INFO - Using env: {'DISPLAY': ':0', 10:15:14 INFO - 'HOME': '/home/cltbld', 10:15:14 INFO - 'LANG': 'en_US.UTF-8', 10:15:14 INFO - 'LANGUAGE': 'en_US:en', 10:15:14 INFO - 'LOGNAME': 'cltbld', 10:15:14 INFO - 'MAIL': '/var/mail/cltbld', 10:15:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:14 INFO - 'MOZ_NO_REMOTE': '1', 10:15:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:14 INFO - 'NO_EM_RESTART': '1', 10:15:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:14 INFO - 'PWD': '/builds/slave/test', 10:15:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:14 INFO - 'SHELL': '/bin/bash', 10:15:14 INFO - 'SHLVL': '1', 10:15:14 INFO - 'TERM': 'linux', 10:15:14 INFO - 'TMOUT': '86400', 10:15:14 INFO - 'USER': 'cltbld', 10:15:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043', 10:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:14 INFO - '_': '/tools/buildbot/bin/python'} 10:15:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:15:14 INFO - mozversion application_buildid: 20161104073159 10:15:14 INFO - mozversion application_changeset: 9c6b3b3a119bc48f5d12e3161218e98adaa12627 10:15:14 INFO - mozversion application_display_name: Nightly 10:15:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:14 INFO - mozversion application_name: Firefox 10:15:14 INFO - mozversion application_remotingname: firefox 10:15:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:15:14 INFO - mozversion application_vendor: Mozilla 10:15:14 INFO - mozversion application_version: 52.0a1 10:15:14 INFO - mozversion platform_buildid: 20161104073159 10:15:14 INFO - mozversion platform_changeset: 9c6b3b3a119bc48f5d12e3161218e98adaa12627 10:15:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:15:14 INFO - mozversion platform_version: 52.0a1 10:15:14 INFO - using testdate: 1478279714 10:15:14 INFO - actual date: 1478279714 10:15:14 INFO - starting webserver on 'localhost:59447' 10:15:14 INFO - SUITE-START | Running 2 tests 10:15:14 INFO - TEST-START | dromaeo_css 10:15:14 INFO - operating with platform_type : linux_ 10:15:14 INFO - Initialising browser for dromaeo_css test... 10:15:14 INFO - TEST-INFO | started process 3299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4WW_Fy/profile http://localhost:59447/getInfo.html) 10:15:20 INFO - PROCESS | 3299 | __metrics Screen width/height:1600/1200 10:15:20 INFO - PROCESS | 3299 | colorDepth:24 10:15:20 INFO - PROCESS | 3299 | Browser inner width/height: 1024/697 10:15:20 INFO - PROCESS | 3299 | __metrics 10:15:21 INFO - PROCESS | 3299 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:15:21 INFO - PROCESS | 3299 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:22 INFO - PROCESS | 3299 | console.error: PushService: 10:15:22 INFO - PROCESS | 3299 | stateChangeProcessEnqueue: Error transitioning state 10:15:22 INFO - PROCESS | 3299 | UnknownError 10:15:22 INFO - TEST-INFO | 3299: exit 0 10:15:22 INFO - Browser initialized. 10:15:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:22 INFO - TEST-INFO | started process 3384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4WW_Fy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:34 INFO - PROCESS | 3384 | RSS: Main: 173359104 10:15:34 INFO - PROCESS | 3384 | 10:16:25 INFO - PROCESS | 3384 | 1478279785937 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] 10:18:36 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:59447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59447/tests/dromaeo/cssquery-ext.html) 10:18:39 INFO - PROCESS | 3384 | RSS: Main: 425267200 10:18:39 INFO - PROCESS | 3384 | 10:21:42 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:59447/tests/dromaeo/cssquery-ext.html (next: http://localhost:59447/tests/dromaeo/cssquery-jquery.html) 10:21:42 INFO - PROCESS | 3384 | RSS: Main: 296923136 10:21:42 INFO - PROCESS | 3384 | 10:24:44 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:59447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59447/tests/dromaeo/cssquery-mootools.html) 10:24:45 INFO - PROCESS | 3384 | RSS: Main: 290746368 10:24:45 INFO - PROCESS | 3384 | 10:27:47 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:59447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59447/tests/dromaeo/cssquery-prototype.html) 10:27:47 INFO - PROCESS | 3384 | RSS: Main: 222412800 10:27:47 INFO - PROCESS | 3384 | 10:30:50 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:59447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59447/tests/dromaeo/cssquery-yui.html) 10:30:51 INFO - PROCESS | 3384 | RSS: Main: 223502336 10:30:51 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:59447/tests/dromaeo/cssquery-yui.html (next: http://localhost:59447/tests/dromaeo/cssquery-dojo.html) 10:33:54 INFO - PROCESS | 3384 | RSS: Main: 319262720 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | __start_tp_report 10:33:54 INFO - PROCESS | 3384 | _x_x_mozilla_page_load 10:33:54 INFO - PROCESS | 3384 | _x_x_mozilla_page_load_details 10:33:54 INFO - PROCESS | 3384 | |i|pagename|runs| 10:33:54 INFO - PROCESS | 3384 | |0;dojo.html;3020.501617233156;3026.8183908965448;3058.969410305898;3070.032939624018;3075.876964921403;5225.973870130653;5276.894462110756;5322.467753224681;5330.387005494369;5360.437154098817;5331.493508116722;5342.1452567589195;5346.4118946915905;5356.598255130862;5360.624756267063;4843.200871856139;4864.075825593143;4884.780184891689;4910.6317026223;4943.307936888838;4862.173430516803;4895.971845912362;4897.461279259279;4897.461279259279;4898;4826.734529600871;4895.853124406273;4948.7773050212645;4990.500949904998;4998.375203099613;5023.346964894558;5050.646454748169;5050.646454748169;5052.393712754493;5110.080185566597;4701.576858082754;4760.428748550162;4852.611791056707;4937.827176048857;4942.975285123587;5326.813561525328;5327.334083239595;5357.491038351351;5396.622236443451;5428.538574221196;5642.069058605325;5698.259226300595;5700.315962084576;5704.11586204139;5712.057510510761;5479.53423958964;5551.944480555183;5735.512481439083;5757.535070837849;5759.68321742304;5303.390110137307;5383.138697808371;5393.352797664305;5450.890982180374;5454.7272636368025;5847.736851841677;5855.209546711225;5862.560307976919;5865.794697185578;5868;5453.563714902798;5506.559475241971;5647.943520564824;5660.29246344207;5662.66024038559;5643.971780141155;5693.857653558694;5735.598508104476;5767.36558978512;5838;5685.829425117253;5701.372848986608;5742.7415766290615;5745.1669507921115;5755.22304488897;5492.340919089735;5724.055530837449;5726.914096288559;5727.599068065196;5786.3056433228285;4344.869653910388;4385.144896745104;4423;4424.823007079681;4434.046679963823;3951.8221680024467;3954.2289253595272;3981.343078392033;3999.460072890181;4011.0373510357304;5420.268263784417;5430.864228394243;5435.673859568438;5436.29328187341;5484.369297530755;5510.559155267569;5565.387807341189;5685.715714214272;5765.798197063083;5773.220615216976;5449.04641687703;5464.890702185934;5511.751971161308;5519.558435325164;5529.142982837667;4941.703497790144;4972.651914366032;4978.079055374767;4978.228374601942;5039.899202015939;5762.394948530512;5831.300243970751;5943.554233432424;6006.789762358297;6011.887800756874;5674.546036317167;5719.628224165416;5748.080307150836;5764.567657425626;5801.82594522165;5940.138679891478;5940.554458415722;5946.5540084494705;5953.166556681981;6003.6998150093195;5583.469570390806;5596.664200148004;5600.243967064557;5607.5513958884;5632.324121105494;5520.475554822286;5623.550115990629;5631.408702086222;5679.5172410345585;5687.886242275049;5527.723613819373;5571.526420254324;5575.163725441216;5577.888442231214;5579.46995035471;5554.111342185231;5557.610967232416;5558.194061861089;5562.694051827189;5564.888702225851;5454.481824226692;5464.1257398816;5496.367917689517;5500.092484740133;5505.311836020497;5583.69289689071;5595.188697638738;5600.887982240414;5601.551875849841;5605.943940560705;5471.671699698031;5484.122540393678;5484.341878974548;5484.862878427912;5489.670619762827 10:33:54 INFO - PROCESS | 3384 | |1;ext.html;592.5999950033727;597.5309382135024;608.473670275212;608.7169466198217;610.877824435113;31936.840315798418;41497.58502414979;42684;43153.56846431535;45879.54120458803;43355;43819.46631867885;43901.341479877745;43922.34116488247;43930;8024;8794.076621954699;8936.195742383185;8940.910590894106;8948.507832069234;8113.21509267963;10430.582776688962;10681.946590267038;10709.196810239264;11036.944815275912;10782.514786834612;10849.891501085007;10858.34849909004;10862.511186996564;10863.18526110545;10572.418516981563;10628.309159904658;10650.946745266301;10683.412412317319;10736.530597962474;10525.894741052569;10568.841467377995;10599.258051936367;10602.946985265024;10604.098651614622;41138.588614113774;41449.1710165798;41500.1699966002;41521.37717934234;41540;3246.4481038223557;3308.8180150091735;3471.1842716961496;3627.9274414511824;3710.5547334319785;31169.204536442187;31282.843585782153;31290.687093129232;31342.529862052088;31487.212819679462;4010.278149933011;4023.482669671164;4027.114034912344;4136;4198.91602167958;332816;333437;333664;334436;335101;33866;35111.64888351084;55475.72262138664;55915.72042139763;56043.71978140083;36295.55941032082;36690.633093669254;36709.81645091758;36728.26543469116;36730.44904326437;14342.928285358716;14454.85545144556;14456.27718614065;14464.27678616065;14466.27668616586;10882.891171088346;11161.665150045512;11632.360220187802;11903.285802851857;11939.462724177432;8408.285295749807;8417.494950302878;8440.198181172902;8496.872546911802;8547.316214702809;3344.39800835847;3346.8828590999196;3365.1082463147286;3366.3435630052395;3399.014285857123;966.5312323523226;989.9653512127041;1001.4291853643354;1005.2209537608412;1039.9636012739518;30977.225569360497;31214.21964450907;31303.53044704331;31360.37279254402;31479.685203148132;1066.0458889294039;1083.095615161349;1101.0475938313302;1141.4064686363045;1168.281506873284;15997;16195.919020404823;16454.588635284214;16539.173041348124;16648.500544983668;472609;475085;476806;477355;478781;55925.44074559284;56344;56445;56454.7177264111;56461.81303710939;1205.891469767725;1269.073576289314;1288.15625765124;1331.6005198440623;1353.8578449262882;29978.85010574933;30694;32064;32187;32513.187170320933;48353.758231208616;49011.264831028275;49018.75490622667;49034.75482622564;49037.754811225714;383594;383722;384286;385843;386241;26780.330491737863;27206.455870882866;27437.725622743517;29003.274918127216;29060.7093929058;46043;46493.3026004617;46622;46648;46946.53053469422;39992.200155996135;40250;41466;41467.7926610365;43228.135437291705;40699;42640.37556807706;43619;44138.02052141952;45220.54779452163;41641.58358416498;41980;42048.57951420569;42744.14511709811;42839;40971;42251.3662295072;42488.78755606202;42521;42834.07408147978;27328.863355683094;28449.857750711115;28616.71383286224;28635.28411789722;28688.42623147567 10:33:54 INFO - PROCESS | 3384 | |2;jquery.html;358.1029521049773;374.60666300384605;383.0825173708966;385.37761515153034;417.8224254691757;14267.286635668213;14974;18163.638726965477;18796.812031879675;18816.059197040144;18624.534386640342;18818.90590547049;18882.905585472086;19003.144858481366;19028.80971190291;4143.544210136883;5502.80740174093;5715.914261286084;5727.57043221758;5735.713214339266;4281.35779633056;6040.426159514839;6285.02582099773;6341.841453963665;6446.967765161167;6238.376162383771;6367.458766004896;6416.390442907917;6457.9677101614425;6468.223813142429;6381.042843573455;6412.166418365606;6422.325655806167;6425.742970281183;6427.132337134473;5480.26016487773;5641.12562552805;5678.176664383683;5679.119736440817;5687.033204355228;22506;23141.884290578608;23148.18981335645;23176.76823231763;23393.649095263416;2218.2125345502277;2316.3630001749484;2413.9879300603384;2504.474060447308;2904.244896326949;9872;10538.420386878719;14198.645033874132;14242.501512447117;15017.699646007019;1874.812518748128;1934.303650685752;1948.5907959328558;1965.2826718247736;2019.9495012624802;79306.60346698287;81608.59195704042;82029.58985205095;82120;84448.15551844526;10768.138548916068;10931.508082136323;11020.338779673246;11125.388103654215;11204.495797689124;15146.772798408032;15170.24148792556;15194.088354698753;15223.695526089416;15268.770968435483;7808.6095695216145;7915.190107511866;7988.6804527819395;8055.711086226176;8226.670933162606;7683.9231607683205;7712.305892469704;7948.205179482121;7990.560519171501;7995.720149794729;4621.3068039793625;4651.697639653412;4698.154332220233;4713.552212539803;4768.499307572724;1926.3546711851407;1956.6967120096408;1981.8216360527333;1988.8607797454329;1993.1927569334443;900.4597241654955;909.4316052467208;967.192394350711;987.6740675577042;991.2763682511807;17582.91208543949;19105.90447047756;19133.13900874436;19159.32942347039;19527;932.7201839448138;933.9813203735887;944.2068662323544;957.674390707163;966.7969726357544;8238.794030149294;10111.231538411568;10652.659434239054;10712;10819.296745711661;394529;403249;410686;412394;412429;49938.50061499338;76910.61544692241;85631.57184214164;87168;87225.56387218024;969.9224062075158;973.8003709239589;1001.5442973447064;1001.8246806808925;1002.1231422505308;15984.200789960689;16578.75131873047;16717.49847504577;16826.158692065103;17053.317867285168;35154.296914061066;40848.387274191504;41052.38421423621;41148.1770364585;41174.38238426366;50791;52468.737656311474;52708.472915271894;54531.454685452634;61319.38680613137;7938.483998540077;8205.548694821842;8535.95732021336;8698.695545655872;8733.606987685696;9138.771530711785;12414.62756117318;13141.277229752455;13288.800667990181;13334.533291335145;10474.266801323834;11195.216334856808;11203.71990700239;11260.324380537195;11282.830757538479;5024.246363045572;7933.444658873824;10769.007733569002;11037.889621103686;11677.824832627348;11056;11059.170562207706;11198.552057917917;11518.82721759191;11838.763224735629;7269.963650181715;7746.496477729155;8481.2366886978;8509.87235191485;8957.955210223907;10970.561177552809;11343.262687925258;11415.885841141482;11595.768084638428;11599.420028998686 10:33:54 INFO - PROCESS | 3384 | |3;mootools.html;1316.822228999085;1423.8319738581654;1446.855314468553;1528.5796405988358;1692.137010124836;6607.8348041299;7470.738524151656;7771.455998080137;7783.64973576189;8221.972253468317;8081.232282933127;8153.510789352643;8158.91841081589;8165.142660020701;8171.305439037674;2265.422317309084;2276.203328834911;2279.213671283413;2281.1445707859552;2289.919852805152;2236.9217077402295;2289.5420915816903;2303.9078436862505;2306.6194077977116;2312.5259321839067;2260.977390226093;2268.353519247015;2287.005152758555;2289.7710228977135;2291.255342013844;2167.4039639099215;2174.1194816099505;2189.3650841256017;2189.6715492676067;2192.8684278943233;2174.097749433983;2228.320362289501;2229.8662080275235;2235.251190851067;2235.8770267635273;7933.286004259644;8171.223733745344;8248.628811703487;8255.215754503313;8255.752327430188;5063.291139240509;5204.29741984831;5206.635535512516;5209.817656382046;5226.7909283628605;3269.1500209945348;3337.632860385356;3340.2317466982486;3414.8634054637787;3428.4171690812373;1094.162965331522;1098.8626421697288;1102.3716481605488;1120.5685810962757;1151.2516864038441;11258.887411125948;11308.151888608387;11317.434128293553;11396.202265841395;11405.54377824886;4069.2471892699355;4380.342948557678;4403.691741578059;4477.037436951071;4480.686351955397;9031.548422578844;9032.141946515201;9035.77410564728;9040.547972601344;9044.457332560067;4994.250862370601;5042.974785126051;5048;5052.974735126374;5063.772130254148;3930.9213815723524;4055.0673345130785;4541.455025396974;4664.510226426244;4746.38297021385;3549.2723991581665;3592.7305452091196;3650.525431693916;3678.521792167001;3704;1122.6519778868576;1132.8527291452058;1144.742432952579;1150.7813515432042;1158.3802665573878;878.1789027259533;884.6682494064726;887.2148148888151;894.3832730452767;922.864876202275;5351.331083614548;5480;5502.669839809624;5524.58565607581;5680.97159514208;437.7723583736439;446.23025281389994;459.3729559151734;459.51291630871384;464.20389032808896;3687.612800655946;3799.506064211635;3808.1050953026015;3847.4228865670375;3870.767753934773;9818.852717209247;10162.288639795292;10190.949045254874;10349.534270957825;10354;9801.215902727765;9823.656172033945;9927.553260103312;9943.15483183923;9948.80102397948;7509.624518774149;7561.130469995911;7913.44605877583;8000.239977202156;8012.399070069768;5460.945390546044;5496.4503549646315;5560.582956278215;5565.7217139143695;5731.283589551306;9087.36388452802;9097.636094556408;9151.450912945245;9177.265818734351;9286.442813431217;9030.36787424874;9430.19843313326;9561.760955976157;9565.90434095678;9566.282528810507;5725;5877.23595932526;6706.429953453816;6973.5118541701595;7056.7530136444975;7545.50954187976;7888.605569721606;7901.288884000468;7912.9208707912185;7952.880706789519;7064.752733654297;7141.9642901785155;7153.391961683107;7155.570665760071;7330.853382932205;6927.515073944775;6997.440204783707;7026.086608740831;7158.8926166108595;7167.569945803269;6730.8653826924165;6742.5280230383405;6791.864162716619;6801.795946121624;6806.8638627228165;4788.592969597484;4890.9021819562695;4996.975015125046;5001.499550134872;5079.492050794891;4782.569568738831;4829.637777166657;4835.758212089452;4843.467218606021;5112.948870511247 10:33:54 INFO - PROCESS | 3384 | |4;prototype.html;324.9707526322631;326.5754519125138;332.8485539079719;333.7430178762352;336.3659501839031;5224.973875130624;5256.211568264762;5289;5290.735463226838;5297.284866543016;5191.442567229835;5204.8809505956215;5234.476552344773;5246.947530524693;5260.842174734755;3875.457435958968;3953.1303113315025;4065.4714887064642;4066;4081.653059489947;4084.1423301106656;4095.1400205956784;4103.7948102594755;4114.588541145877;4126.174765046988;4057.3305404608204;4058.289799285113;4071.694622903294;4084.1627466369473;4109.342505199169;3983.6215559521943;4056.71602987791;4058.5129784425762;4069.532003819569;4086.6730661547153;3582.3193593217466;3594.8741794037346;3597.9100522486888;3601.1537288737127;3609.927801443983;5096.216324286507;5096.235564665293;5107.693538387709;5111.7699703513435;5117.1556693145585;4455.22033644111;4625.699329543569;4665.6967297125575;4670.462896766881;4670.836520721792;5439.38909323523;5441.755121019524;5442.292501974757;5443.020256353894;5488.807891723811;3937.822797974098;3940.6059394060653;3954.4661470701662;3954.9604503955165;3957.28768821612;5302.681839089667;5626.578006649477;5632.746526406321;5662.989638678292;5702.7433765480655;3962.306596345628;4005.3377848193254;4013.4381186633896;4047.1096358801015;4047.392891066305;4064.2684316822665;4075.836966521306;4083.1629515949157;4086.59134086589;4112.527059388149;4601.608863246594;4701.247800351927;4720.834770783006;4734.147853386355;4735.384400027974;5451;5464.672119672832;5512.641678290898;5558.694271815089;5586.16207568868;1384.5846246126323;1393.4356585582855;1402.975827645804;1408.4718230663502;1412.8202950536213;861.6984055580497;895.0959530873735;907.3512438606429;919.6459363145103;924.1867156901883;5162.483751624807;5236.005159019774;5306.177542480922;5358.91961620576;5360.65155764874;5657.12314591239;5658.915116273177;5674.347450043216;5677.37548869624;5681.545476361881;5173.611979101583;5265.657732247469;5297.417284098746;5347.3048503695045;5370.355557333145;2957.31981644223;2993.9850300748794;2997.5803387525766;3003.57949887016;3008.1426793363785;5797.144898642356;5809.838032393538;5823.94176058234;5855.272694555117;5906.734196961061;5535.8892822144135;5661.264035675335;5662.999999999917;5711.771529138871;5732.226149469851;5782.2483077199695;5809.622374545641;5824.854378640483;5826.184334193216;5842.561807864342;5348.331458567679;5505.807296744595;5606.355269143937;5633.802816901389;5688.459596338341;5545.944540554543;5547.8890422190525;5555.30558680165;5572.275604171432;5586.553075753849;5742.28221472316;5763.135529670583;5872.442117998783;5889.793857214977;5918.556108291809;3924.7252692312404;4015.915702760297;4045.8988525287104;4053.2704113259897;4058.3912413138264;5644.887102258014;5646.88706225865;5660.29246344207;5667.5465962722055;5671.517920976763;5500.202470641814;5516.14499752539;5533.841801697261;5545.916811247916;5570.080936645571;5228.241904923841;5450.618456707993;5496.5053145217125;5508.531774799187;5534.1975413565615;5425.511703946506;5437.374701909331;5438.18427235902;5451.236826844166;5484.327280179424;5358.517733404013;5373.382061062872;5438.320209973754;5441.775600489858;5480.671159730429;5351.732413379394;5353.732313384237;5354.491323324278;5368;5386.973065134649 10:33:54 INFO - PROCESS | 3384 | |5;yui.html;690.392454639917;694.1878002736804;730.9451791115667;767.8310771630242;789.8262382275901;13486.865131348684;14642.121472711644;14663.706725865477;14795.85204147957;14825.703485930275;13666.658333541667;13900.026998110136;13908.721825563483;13938.651533711636;13944.860551394482;636.8980963045914;655.6688872119573;758.9241075892422;764.7782143178472;782.5031105248152;783.396784475956;784.9529028258294;785.4030936488253;785.446260386429;785.5522352259214;819.6516480495795;821.2936874288107;821.322409012564;821.7452589697212;821.7534739578102;661.8709351676425;680.8195828105556;682.0451368084696;682.2290811383106;813.8250276190618;587.5886879184588;601.5247954116243;605.503487140545;606.7118118893491;607.2530787131852;13229.140105893086;13229.470821167142;13246.47014119434;13255.734885302336;13260.73478530424;12908.935455322757;13192.604221873358;13334.599962001059;13384.598462046155;13519.797203041962;11562.07503399726;11618.128640352008;11655.825162622483;11987.160898737093;12071.818922716166;4203.4115223868685;4234.830606775725;4252.128313695685;4348.478182618106;4385.978070109661;58742;59025.7048714758;60286.69856650732;62180.37819621791;62897;10755.193360497993;10849.186311026704;10859.07697845692;10859.131269498579;10928.83663982325;19691.11389987454;19930.800691993183;19977.600447990957;19982.20071197165;19983.900080499505;7252.2385149559595;7267.309481854005;7366.668499917517;7462.365698915544;7463.10442746863;4364.258076127066;4373.825046998148;4424.13729322779;4430.867073987785;4454.888627784267;2892.971070289312;3001.3847161331873;3003.804752691068;3004.6094007778847;3006.969930300669;547.4361407750024;553.883684426275;554.2849723856181;564.1678524176806;564.6668465605312;610.3469287861946;613.1232337756961;632.8924082905917;642.948564114879;642.9774957876452;8032.638531266107;8599.355048371397;8606.87089693655;8798.076201998698;8977.596008179517;633.1578999930082;633.6261605652687;634.4099987012123;640.7853369121397;641.9261784894796;4027.3354896442347;4175.979120104441;4178.456800615901;4281.571842815693;4379.759113248738;52187;59001.114983275285;83527;84468.59130712939;88443.55778221067;64149.67925160344;76666;77245.61377193077;79561;82208;55439;60351.698241508515;61983;62110.689446552475;62524;9411.858822117536;9836.852447213441;9872.35829671069;9943.900560994298;10000.749981250236;38951.80524097361;40293.39559906662;41698.791506042275;41883.581164189185;45246.77376613096;54286.82852685848;59289;59307.883054033795;59833.700831497306;63042.36957630365;11585.826212606986;11684.766304673689;11906.583269585522;12328.137030407785;12457.563985260473;12817;12857.614271571867;12981.610551683465;13524.39140238672;13620.250886201355;11871.762564748484;11950.581729639422;12181.269123852597;12271;12460.501579936701;12106.515739370327;12248.203866748632;12313.891749742566;12635.115541911979;13564;12097.939510302393;12134.211276267015;12540.937295313464;12617.621471355875;12640.178388404724;10652.62715804943;10669.50520481968;11050.115990720884;11050.668479945614;11199;10926.344419334866;10936.835947460635;10977.89860993489;11015.504302306575;11021.669349919515 10:33:54 INFO - PROCESS | 3384 | __end_tp_report 10:33:54 INFO - PROCESS | 3384 | __start_cc_report 10:33:54 INFO - PROCESS | 3384 | _x_x_mozilla_cycle_collect,2680 10:33:54 INFO - PROCESS | 3384 | __end_cc_report 10:33:54 INFO - PROCESS | 3384 | __startTimestamp1478280834344__endTimestamp 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | ------- Summary: start ------- 10:33:54 INFO - PROCESS | 3384 | Number of tests: 6 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | [#0] dojo.html Cycles:165 Average:5318.62 Median:5496.37 stddev:590.45 (10.7%) stddev-sans-first:564.06 10:33:54 INFO - PROCESS | 3384 | Values: 3020.5 3026.8 3059.0 3070.0 3075.9 5226.0 5276.9 5322.5 5330.4 5360.4 5331.5 5342.1 5346.4 5356.6 5360.6 4843.2 4864.1 4884.8 4910.6 4943.3 4862.2 4896.0 4897.5 4897.5 4898.0 4826.7 4895.9 4948.8 4990.5 4998.4 5023.3 5050.6 5050.6 5052.4 5110.1 4701.6 4760.4 4852.6 4937.8 4943.0 5326.8 5327.3 5357.5 5396.6 5428.5 5642.1 5698.3 5700.3 5704.1 5712.1 5479.5 5551.9 5735.5 5757.5 5759.7 5303.4 5383.1 5393.4 5450.9 5454.7 5847.7 5855.2 5862.6 5865.8 5868.0 5453.6 5506.6 5647.9 5660.3 5662.7 5644.0 5693.9 5735.6 5767.4 5838.0 5685.8 5701.4 5742.7 5745.2 5755.2 5492.3 5724.1 5726.9 5727.6 5786.3 4344.9 4385.1 4423.0 4424.8 4434.0 3951.8 3954.2 3981.3 3999.5 4011.0 5420.3 5430.9 5435.7 5436.3 5484.4 5510.6 5565.4 5685.7 5765.8 5773.2 5449.0 5464.9 5511.8 5519.6 5529.1 4941.7 4972.7 4978.1 4978.2 5039.9 5762.4 5831.3 5943.6 6006.8 6011.9 5674.5 5719.6 5748.1 5764.6 5801.8 5940.1 5940.6 5946.6 5953.2 6003.7 5583.5 5596.7 5600.2 5607.6 5632.3 5520.5 5623.6 5631.4 5679.5 5687.9 5527.7 5571.5 5575.2 5577.9 5579.5 5554.1 5557.6 5558.2 5562.7 5564.9 5454.5 5464.1 5496.4 5500.1 5505.3 5583.7 5595.2 5600.9 5601.6 5605.9 5471.7 5484.1 5484.3 5484.9 5489.7 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | [#1] ext.html Cycles:180 Average:55352.62 Median:36700.22 stddev:106440.00 (290.0%) stddev-sans-first:106659.18 10:33:54 INFO - PROCESS | 3384 | Values: 592.6 597.5 608.5 608.7 610.9 31936.8 41497.6 42684.0 43153.6 45879.5 43355.0 43819.5 43901.3 43922.3 43930.0 8024.0 8794.1 8936.2 8940.9 8948.5 8113.2 10430.6 10681.9 10709.2 11036.9 10782.5 10849.9 10858.3 10862.5 10863.2 10572.4 10628.3 10650.9 10683.4 10736.5 10525.9 10568.8 10599.3 10602.9 10604.1 41138.6 41449.2 41500.2 41521.4 41540.0 3246.4 3308.8 3471.2 3627.9 3710.6 31169.2 31282.8 31290.7 31342.5 31487.2 4010.3 4023.5 4027.1 4136.0 4198.9 332816.0 333437.0 333664.0 334436.0 335101.0 33866.0 35111.6 55475.7 55915.7 56043.7 36295.6 36690.6 36709.8 36728.3 36730.4 14342.9 14454.9 14456.3 14464.3 14466.3 10882.9 11161.7 11632.4 11903.3 11939.5 8408.3 8417.5 8440.2 8496.9 8547.3 3344.4 3346.9 3365.1 3366.3 3399.0 966.5 990.0 1001.4 1005.2 1040.0 30977.2 31214.2 31303.5 31360.4 31479.7 1066.0 1083.1 1101.0 1141.4 1168.3 15997.0 16195.9 16454.6 16539.2 16648.5 472609.0 475085.0 476806.0 477355.0 478781.0 55925.4 56344.0 56445.0 56454.7 56461.8 1205.9 1269.1 1288.2 1331.6 1353.9 29978.9 30694.0 32064.0 32187.0 32513.2 48353.8 49011.3 49018.8 49034.8 49037.8 383594.0 383722.0 384286.0 385843.0 386241.0 26780.3 27206.5 27437.7 29003.3 29060.7 46043.0 46493.3 46622.0 46648.0 46946.5 39992.2 40250.0 41466.0 41467.8 43228.1 40699.0 42640.4 43619.0 44138.0 45220.5 41641.6 41980.0 42048.6 42744.1 42839.0 40971.0 42251.4 42488.8 42521.0 42834.1 27328.9 28449.9 28616.7 28635.3 28688.4 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | [#2] jquery.html Cycles:180 Average:25989.32 Median:40950.39 stddev:67292.93 (164.3%) stddev-sans-first:67454.18 10:33:54 INFO - PROCESS | 3384 | Values: 358.1 374.6 383.1 385.4 417.8 14267.3 14974.0 18163.6 18796.8 18816.1 18624.5 18818.9 18882.9 19003.1 19028.8 4143.5 5502.8 5715.9 5727.6 5735.7 4281.4 6040.4 6285.0 6341.8 6447.0 6238.4 6367.5 6416.4 6458.0 6468.2 6381.0 6412.2 6422.3 6425.7 6427.1 5480.3 5641.1 5678.2 5679.1 5687.0 22506.0 23141.9 23148.2 23176.8 23393.6 2218.2 2316.4 2414.0 2504.5 2904.2 9872.0 10538.4 14198.6 14242.5 15017.7 1874.8 1934.3 1948.6 1965.3 2019.9 79306.6 81608.6 82029.6 82120.0 84448.2 10768.1 10931.5 11020.3 11125.4 11204.5 15146.8 15170.2 15194.1 15223.7 15268.8 7808.6 7915.2 7988.7 8055.7 8226.7 7683.9 7712.3 7948.2 7990.6 7995.7 4621.3 4651.7 4698.2 4713.6 4768.5 1926.4 1956.7 1981.8 1988.9 1993.2 900.5 909.4 967.2 987.7 991.3 17582.9 19105.9 19133.1 19159.3 19527.0 932.7 934.0 944.2 957.7 966.8 8238.8 10111.2 10652.7 10712.0 10819.3 394529.0 403249.0 410686.0 412394.0 412429.0 49938.5 76910.6 85631.6 87168.0 87225.6 969.9 973.8 1001.5 1001.8 1002.1 15984.2 16578.8 16717.5 16826.2 17053.3 35154.3 40848.4 41052.4 41148.2 41174.4 50791.0 52468.7 52708.5 54531.5 61319.4 7938.5 8205.5 8536.0 8698.7 8733.6 9138.8 12414.6 13141.3 13288.8 13334.5 10474.3 11195.2 11203.7 11260.3 11282.8 5024.2 7933.4 10769.0 11037.9 11677.8 11056.0 11059.2 11198.6 11518.8 11838.8 7270.0 7746.5 8481.2 8509.9 8958.0 10970.6 11343.3 11415.9 11595.8 11599.4 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | [#3] mootools.html Cycles:180 Average:5362.01 Median:5058.13 stddev:3000.01 (59.3%) stddev-sans-first:2993.02 10:33:54 INFO - PROCESS | 3384 | Values: 1316.8 1423.8 1446.9 1528.6 1692.1 6607.8 7470.7 7771.5 7783.6 8222.0 8081.2 8153.5 8158.9 8165.1 8171.3 2265.4 2276.2 2279.2 2281.1 2289.9 2236.9 2289.5 2303.9 2306.6 2312.5 2261.0 2268.4 2287.0 2289.8 2291.3 2167.4 2174.1 2189.4 2189.7 2192.9 2174.1 2228.3 2229.9 2235.3 2235.9 7933.3 8171.2 8248.6 8255.2 8255.8 5063.3 5204.3 5206.6 5209.8 5226.8 3269.2 3337.6 3340.2 3414.9 3428.4 1094.2 1098.9 1102.4 1120.6 1151.3 11258.9 11308.2 11317.4 11396.2 11405.5 4069.2 4380.3 4403.7 4477.0 4480.7 9031.5 9032.1 9035.8 9040.5 9044.5 4994.3 5043.0 5048.0 5053.0 5063.8 3930.9 4055.1 4541.5 4664.5 4746.4 3549.3 3592.7 3650.5 3678.5 3704.0 1122.7 1132.9 1144.7 1150.8 1158.4 878.2 884.7 887.2 894.4 922.9 5351.3 5480.0 5502.7 5524.6 5681.0 437.8 446.2 459.4 459.5 464.2 3687.6 3799.5 3808.1 3847.4 3870.8 9818.9 10162.3 10190.9 10349.5 10354.0 9801.2 9823.7 9927.6 9943.2 9948.8 7509.6 7561.1 7913.4 8000.2 8012.4 5460.9 5496.5 5560.6 5565.7 5731.3 9087.4 9097.6 9151.5 9177.3 9286.4 9030.4 9430.2 9561.8 9565.9 9566.3 5725.0 5877.2 6706.4 6973.5 7056.8 7545.5 7888.6 7901.3 7912.9 7952.9 7064.8 7142.0 7153.4 7155.6 7330.9 6927.5 6997.4 7026.1 7158.9 7167.6 6730.9 6742.5 6791.9 6801.8 6806.9 4788.6 4890.9 4997.0 5001.5 5079.5 4782.6 4829.6 4835.8 4843.5 5112.9 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | [#4] prototype.html Cycles:180 Average:4621.80 Median:5300.05 stddev:1360.58 (25.7%) stddev-sans-first:1325.62 10:33:54 INFO - PROCESS | 3384 | Values: 325.0 326.6 332.8 333.7 336.4 5225.0 5256.2 5289.0 5290.7 5297.3 5191.4 5204.9 5234.5 5246.9 5260.8 3875.5 3953.1 4065.5 4066.0 4081.7 4084.1 4095.1 4103.8 4114.6 4126.2 4057.3 4058.3 4071.7 4084.2 4109.3 3983.6 4056.7 4058.5 4069.5 4086.7 3582.3 3594.9 3597.9 3601.2 3609.9 5096.2 5096.2 5107.7 5111.8 5117.2 4455.2 4625.7 4665.7 4670.5 4670.8 5439.4 5441.8 5442.3 5443.0 5488.8 3937.8 3940.6 3954.5 3955.0 3957.3 5302.7 5626.6 5632.7 5663.0 5702.7 3962.3 4005.3 4013.4 4047.1 4047.4 4064.3 4075.8 4083.2 4086.6 4112.5 4601.6 4701.2 4720.8 4734.1 4735.4 5451.0 5464.7 5512.6 5558.7 5586.2 1384.6 1393.4 1403.0 1408.5 1412.8 861.7 895.1 907.4 919.6 924.2 5162.5 5236.0 5306.2 5358.9 5360.7 5657.1 5658.9 5674.3 5677.4 5681.5 5173.6 5265.7 5297.4 5347.3 5370.4 2957.3 2994.0 2997.6 3003.6 3008.1 5797.1 5809.8 5823.9 5855.3 5906.7 5535.9 5661.3 5663.0 5711.8 5732.2 5782.2 5809.6 5824.9 5826.2 5842.6 5348.3 5505.8 5606.4 5633.8 5688.5 5545.9 5547.9 5555.3 5572.3 5586.6 5742.3 5763.1 5872.4 5889.8 5918.6 3924.7 4015.9 4045.9 4053.3 4058.4 5644.9 5646.9 5660.3 5667.5 5671.5 5500.2 5516.1 5533.8 5545.9 5570.1 5228.2 5450.6 5496.5 5508.5 5534.2 5425.5 5437.4 5438.2 5451.2 5484.3 5358.5 5373.4 5438.3 5441.8 5480.7 5351.7 5353.7 5354.5 5368.0 5387.0 10:33:54 INFO - PROCESS | 3384 | 10:33:54 INFO - PROCESS | 3384 | [#5] yui.html Cycles:180 Average:16689.09 Median:4382.87 stddev:21607.28 (493.0%) stddev-sans-first:21634.50 10:33:54 INFO - PROCESS | 3384 | Values: 690.4 694.2 730.9 767.8 789.8 13486.9 14642.1 14663.7 14795.9 14825.7 13666.7 13900.0 13908.7 13938.7 13944.9 636.9 655.7 758.9 764.8 782.5 783.4 785.0 785.4 785.4 785.6 819.7 821.3 821.3 821.7 821.8 661.9 680.8 682.0 682.2 813.8 587.6 601.5 605.5 606.7 607.3 13229.1 13229.5 13246.5 13255.7 13260.7 12908.9 13192.6 13334.6 13384.6 13519.8 11562.1 11618.1 11655.8 11987.2 12071.8 4203.4 4234.8 4252.1 4348.5 4386.0 58742.0 59025.7 60286.7 62180.4 62897.0 10755.2 10849.2 10859.1 10859.1 10928.8 19691.1 19930.8 19977.6 19982.2 19983.9 7252.2 7267.3 7366.7 7462.4 7463.1 4364.3 4373.8 4424.1 4430.9 4454.9 2893.0 3001.4 3003.8 3004.6 3007.0 547.4 553.9 554.3 564.2 564.7 610.3 613.1 632.9 642.9 643.0 8032.6 8599.4 8606.9 8798.1 8977.6 633.2 633.6 634.4 640.8 641.9 4027.3 4176.0 4178.5 4281.6 4379.8 52187.0 59001.1 83527.0 84468.6 88443.6 64149.7 76666.0 77245.6 79561.0 82208.0 55439.0 60351.7 61983.0 62110.7 62524.0 9411.9 9836.9 9872.4 9943.9 10000.7 38951.8 40293.4 41698.8 41883.6 45246.8 54286.8 59289.0 59307.9 59833.7 63042.4 11585.8 11684.8 11906.6 12328.1 12457.6 12817.0 12857.6 12981.6 13524.4 13620.3 11871.8 11950.6 12181.3 12271.0 12460.5 12106.5 12248.2 12313.9 12635.1 13564.0 12097.9 12134.2 12540.9 12617.6 12640.2 10652.6 10669.5 11050.1 11050.7 11199.0 10926.3 10936.8 10977.9 11015.5 11021.7 10:33:54 INFO - PROCESS | 3384 | -------- Summary: end -------- 10:33:54 INFO - PROCESS | 3384 | 10:33:55 INFO - TEST-INFO | 3384: exit 0 10:33:55 INFO - TEST-OK | dromaeo_css | took 1120407ms 10:33:55 INFO - TEST-START | kraken 10:33:55 INFO - operating with platform_type : linux_ 10:33:55 INFO - Initialising browser for kraken test... 10:33:55 INFO - TEST-INFO | started process 3689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkCOGxY/profile http://localhost:59447/getInfo.html) 10:33:59 INFO - PROCESS | 3689 | __metrics Screen width/height:1600/1200 10:33:59 INFO - PROCESS | 3689 | colorDepth:24 10:33:59 INFO - PROCESS | 3689 | Browser inner width/height: 1024/697 10:33:59 INFO - PROCESS | 3689 | __metrics 10:33:59 INFO - PROCESS | 3689 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:33:59 INFO - PROCESS | 3689 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:00 INFO - PROCESS | 3689 | console.error: PushService: 10:34:00 INFO - PROCESS | 3689 | stateChangeProcessEnqueue: Error transitioning state 10:34:00 INFO - PROCESS | 3689 | UnknownError 10:34:01 INFO - TEST-INFO | 3689: exit 0 10:34:01 INFO - Browser initialized. 10:34:01 INFO - Running cycle 1/1 for kraken test... 10:34:01 INFO - TEST-INFO | started process 3772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkCOGxY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:13 INFO - PROCESS | 3772 | RSS: Main: 173645824 10:34:13 INFO - PROCESS | 3772 | 10:34:15 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59447/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:16 INFO - PROCESS | 3772 | RSS: Main: 229711872 10:34:16 INFO - PROCESS | 3772 | 10:34:19 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59447/tests/kraken/driver.html?testName=audio-dft) 10:34:19 INFO - PROCESS | 3772 | RSS: Main: 216875008 10:34:19 INFO - PROCESS | 3772 | 10:34:23 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59447/tests/kraken/driver.html?testName=audio-fft) 10:34:23 INFO - PROCESS | 3772 | RSS: Main: 297439232 10:34:23 INFO - PROCESS | 3772 | 10:34:25 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59447/tests/kraken/driver.html?testName=audio-oscillator) 10:34:26 INFO - PROCESS | 3772 | RSS: Main: 206995456 10:34:26 INFO - PROCESS | 3772 | 10:34:28 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:29 INFO - PROCESS | 3772 | RSS: Main: 212938752 10:34:29 INFO - PROCESS | 3772 | 10:34:32 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59447/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:32 INFO - PROCESS | 3772 | RSS: Main: 248496128 10:34:32 INFO - PROCESS | 3772 | 10:34:35 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59447/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:36 INFO - PROCESS | 3772 | RSS: Main: 247455744 10:34:36 INFO - PROCESS | 3772 | 10:34:39 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59447/tests/kraken/driver.html?testName=json-parse-financial) 10:34:39 INFO - PROCESS | 3772 | RSS: Main: 246685696 10:34:39 INFO - PROCESS | 3772 | 10:34:41 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:41 INFO - PROCESS | 3772 | RSS: Main: 209448960 10:34:41 INFO - PROCESS | 3772 | 10:34:43 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:44 INFO - PROCESS | 3772 | RSS: Main: 217358336 10:34:44 INFO - PROCESS | 3772 | 10:34:46 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:46 INFO - PROCESS | 3772 | RSS: Main: 225628160 10:34:46 INFO - PROCESS | 3772 | 10:34:49 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:50 INFO - PROCESS | 3772 | RSS: Main: 235020288 10:34:50 INFO - PROCESS | 3772 | 10:34:53 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:53 INFO - PROCESS | 3772 | RSS: Main: 231079936 10:34:53 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:59447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59447/tests/kraken/driver.html?testName=ai-astar) 10:34:55 INFO - PROCESS | 3772 | RSS: Main: 281989120 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | __start_tp_report 10:34:55 INFO - PROCESS | 3772 | _x_x_mozilla_page_load 10:34:55 INFO - PROCESS | 3772 | _x_x_mozilla_page_load_details 10:34:55 INFO - PROCESS | 3772 | |i|pagename|runs| 10:34:55 INFO - PROCESS | 3772 | |0;ai-astar;105;113;114;114;113;114;114;113;113;113 10:34:55 INFO - PROCESS | 3772 | |1;audio-beat-detection;149;123;121;156;126;128;129;120;156;126 10:34:55 INFO - PROCESS | 3772 | |2;audio-dft;162;161;162;161;164;160;161;160;162;161 10:34:55 INFO - PROCESS | 3772 | |3;audio-fft;74;76;74;110;76;76;77;76;101;75 10:34:55 INFO - PROCESS | 3772 | |4;audio-oscillator;83;84;106;83;83;84;101;83;83;114 10:34:55 INFO - PROCESS | 3772 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 10:34:55 INFO - PROCESS | 3772 | |6;imaging-darkroom;145;146;146;145;146;146;146;145;145;145 10:34:55 INFO - PROCESS | 3772 | |7;imaging-desaturate;84;84;84;85;84;84;85;85;84;85 10:34:55 INFO - PROCESS | 3772 | |8;json-parse-financial;52;52;53;52;52;53;53;53;53;54 10:34:55 INFO - PROCESS | 3772 | |9;json-stringify-tinderbox;61;61;60;61;61;61;61;61;60;61 10:34:55 INFO - PROCESS | 3772 | |10;stanford-crypto-aes;80;87;80;87;80;79;88;81;85;79 10:34:55 INFO - PROCESS | 3772 | |11;stanford-crypto-ccm;147;145;134;130;134;133;138;136;171;144 10:34:55 INFO - PROCESS | 3772 | |12;stanford-crypto-pbkdf2;180;170;170;172;172;166;166;173;167;173 10:34:55 INFO - PROCESS | 3772 | |13;stanford-crypto-sha256-iterative;63;64;64;74;64;65;64;64;67;64 10:34:55 INFO - PROCESS | 3772 | __end_tp_report 10:34:55 INFO - PROCESS | 3772 | __start_cc_report 10:34:55 INFO - PROCESS | 3772 | _x_x_mozilla_cycle_collect,1652 10:34:55 INFO - PROCESS | 3772 | __end_cc_report 10:34:55 INFO - PROCESS | 3772 | __startTimestamp1478280895551__endTimestamp 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | ------- Summary: start ------- 10:34:55 INFO - PROCESS | 3772 | Number of tests: 14 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:2.72 (2.4%) stddev-sans-first:0.53 10:34:55 INFO - PROCESS | 3772 | Values: 105.0 113.0 114.0 114.0 113.0 114.0 114.0 113.0 113.0 113.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:128.50 stddev:14.39 (11.2%) stddev-sans-first:14.12 10:34:55 INFO - PROCESS | 3772 | Values: 149.0 123.0 121.0 156.0 126.0 128.0 129.0 120.0 156.0 126.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 10:34:55 INFO - PROCESS | 3772 | Values: 162.0 161.0 162.0 161.0 164.0 160.0 161.0 160.0 162.0 161.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:12.86 (16.9%) stddev-sans-first:13.35 10:34:55 INFO - PROCESS | 3772 | Values: 74.0 76.0 74.0 110.0 76.0 76.0 77.0 76.0 101.0 75.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.00 stddev:11.87 (14.3%) stddev-sans-first:12.29 10:34:55 INFO - PROCESS | 3772 | Values: 83.0 84.0 106.0 83.0 83.0 84.0 101.0 83.0 83.0 114.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:34:55 INFO - PROCESS | 3772 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:34:55 INFO - PROCESS | 3772 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 10:34:55 INFO - PROCESS | 3772 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 85.0 85.0 84.0 85.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.67 10:34:55 INFO - PROCESS | 3772 | Values: 52.0 52.0 53.0 52.0 52.0 53.0 53.0 53.0 53.0 54.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 10:34:55 INFO - PROCESS | 3772 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:3.69 (4.4%) stddev-sans-first:3.79 10:34:55 INFO - PROCESS | 3772 | Values: 80.0 87.0 80.0 87.0 80.0 79.0 88.0 81.0 85.0 79.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:141.00 stddev:11.91 (8.5%) stddev-sans-first:12.45 10:34:55 INFO - PROCESS | 3772 | Values: 147.0 145.0 134.0 130.0 134.0 133.0 138.0 136.0 171.0 144.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:172.00 stddev:4.20 (2.4%) stddev-sans-first:2.89 10:34:55 INFO - PROCESS | 3772 | Values: 180.0 170.0 170.0 172.0 172.0 166.0 166.0 173.0 167.0 173.0 10:34:55 INFO - PROCESS | 3772 | 10:34:55 INFO - PROCESS | 3772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:64.00 stddev:3.23 (5.1%) stddev-sans-first:3.32 10:34:55 INFO - PROCESS | 3772 | Values: 63.0 64.0 64.0 74.0 64.0 65.0 64.0 64.0 67.0 64.0 10:34:55 INFO - PROCESS | 3772 | -------- Summary: end -------- 10:34:55 INFO - PROCESS | 3772 | 10:34:56 INFO - TEST-INFO | 3772: exit 0 10:34:56 INFO - TEST-OK | kraken | took 61556ms 10:34:56 INFO - SUITE-END | took 1181s 10:34:57 INFO - Completed test suite (00:19:42) 10:34:57 INFO - javascript benchmark 10:34:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.501617233156, 3026.8183908965448, 3058.969410305898, 3070.032939624018, 3075.876964921403, 5225.973870130653, 5276.894462110756, 5322.467753224681, 5330.387005494369, 5360.437154098817, 5331.493508116722, 5342.1452567589195, 5346.4118946915905, 5356.598255130862, 5360.624756267063, 4843.200871856139, 4864.075825593143, 4884.780184891689, 4910.6317026223, 4943.307936888838, 4862.173430516803, 4895.971845912362, 4897.461279259279, 4897.461279259279, 4898.0, 4826.734529600871, 4895.853124406273, 4948.7773050212645, 4990.500949904998, 4998.375203099613, 5023.346964894558, 5050.646454748169, 5050.646454748169, 5052.393712754493, 5110.080185566597, 4701.576858082754, 4760.428748550162, 4852.611791056707, 4937.827176048857, 4942.975285123587, 5326.813561525328, 5327.334083239595, 5357.491038351351, 5396.622236443451, 5428.538574221196, 5642.069058605325, 5698.259226300595, 5700.315962084576, 5704.11586204139, 5712.057510510761, 5479.53423958964, 5551.944480555183, 5735.512481439083, 5757.535070837849, 5759.68321742304, 5303.390110137307, 5383.138697808371, 5393.352797664305, 5450.890982180374, 5454.7272636368025, 5847.736851841677, 5855.209546711225, 5862.560307976919, 5865.794697185578, 5868.0, 5453.563714902798, 5506.559475241971, 5647.943520564824, 5660.29246344207, 5662.66024038559, 5643.971780141155, 5693.857653558694, 5735.598508104476, 5767.36558978512, 5838.0, 5685.829425117253, 5701.372848986608, 5742.7415766290615, 5745.1669507921115, 5755.22304488897, 5492.340919089735, 5724.055530837449, 5726.914096288559, 5727.599068065196, 5786.3056433228285, 4344.869653910388, 4385.144896745104, 4423.0, 4424.823007079681, 4434.046679963823, 3951.8221680024467, 3954.2289253595272, 3981.343078392033, 3999.460072890181, 4011.0373510357304, 5420.268263784417, 5430.864228394243, 5435.673859568438, 5436.29328187341, 5484.369297530755, 5510.559155267569, 5565.387807341189, 5685.715714214272, 5765.798197063083, 5773.220615216976, 5449.04641687703, 5464.890702185934, 5511.751971161308, 5519.558435325164, 5529.142982837667, 4941.703497790144, 4972.651914366032, 4978.079055374767, 4978.228374601942, 5039.899202015939, 5762.394948530512, 5831.300243970751, 5943.554233432424, 6006.789762358297, 6011.887800756874, 5674.546036317167, 5719.628224165416, 5748.080307150836, 5764.567657425626, 5801.82594522165, 5940.138679891478, 5940.554458415722, 5946.5540084494705, 5953.166556681981, 6003.6998150093195, 5583.469570390806, 5596.664200148004, 5600.243967064557, 5607.5513958884, 5632.324121105494, 5520.475554822286, 5623.550115990629, 5631.408702086222, 5679.5172410345585, 5687.886242275049, 5527.723613819373, 5571.526420254324, 5575.163725441216, 5577.888442231214, 5579.46995035471, 5554.111342185231, 5557.610967232416, 5558.194061861089, 5562.694051827189, 5564.888702225851, 5454.481824226692, 5464.1257398816, 5496.367917689517, 5500.092484740133, 5505.311836020497, 5583.69289689071, 5595.188697638738, 5600.887982240414, 5601.551875849841, 5605.943940560705, 5471.671699698031, 5484.122540393678, 5484.341878974548, 5484.862878427912, 5489.670619762827], "value": 5279.120729999451, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5999950033727, 597.5309382135024, 608.473670275212, 608.7169466198217, 610.877824435113, 31936.840315798418, 41497.58502414979, 42684.0, 43153.56846431535, 45879.54120458803, 43355.0, 43819.46631867885, 43901.341479877745, 43922.34116488247, 43930.0, 8024.0, 8794.076621954699, 8936.195742383185, 8940.910590894106, 8948.507832069234, 8113.21509267963, 10430.582776688962, 10681.946590267038, 10709.196810239264, 11036.944815275912, 10782.514786834612, 10849.891501085007, 10858.34849909004, 10862.511186996564, 10863.18526110545, 10572.418516981563, 10628.309159904658, 10650.946745266301, 10683.412412317319, 10736.530597962474, 10525.894741052569, 10568.841467377995, 10599.258051936367, 10602.946985265024, 10604.098651614622, 41138.588614113774, 41449.1710165798, 41500.1699966002, 41521.37717934234, 41540.0, 3246.4481038223557, 3308.8180150091735, 3471.1842716961496, 3627.9274414511824, 3710.5547334319785, 31169.204536442187, 31282.843585782153, 31290.687093129232, 31342.529862052088, 31487.212819679462, 4010.278149933011, 4023.482669671164, 4027.114034912344, 4136.0, 4198.91602167958, 332816.0, 333437.0, 333664.0, 334436.0, 335101.0, 33866.0, 35111.64888351084, 55475.72262138664, 55915.72042139763, 56043.71978140083, 36295.55941032082, 36690.633093669254, 36709.81645091758, 36728.26543469116, 36730.44904326437, 14342.928285358716, 14454.85545144556, 14456.27718614065, 14464.27678616065, 14466.27668616586, 10882.891171088346, 11161.665150045512, 11632.360220187802, 11903.285802851857, 11939.462724177432, 8408.285295749807, 8417.494950302878, 8440.198181172902, 8496.872546911802, 8547.316214702809, 3344.39800835847, 3346.8828590999196, 3365.1082463147286, 3366.3435630052395, 3399.014285857123, 966.5312323523226, 989.9653512127041, 1001.4291853643354, 1005.2209537608412, 1039.9636012739518, 30977.225569360497, 31214.21964450907, 31303.53044704331, 31360.37279254402, 31479.685203148132, 1066.0458889294039, 1083.095615161349, 1101.0475938313302, 1141.4064686363045, 1168.281506873284, 15997.0, 16195.919020404823, 16454.588635284214, 16539.173041348124, 16648.500544983668, 472609.0, 475085.0, 476806.0, 477355.0, 478781.0, 55925.44074559284, 56344.0, 56445.0, 56454.7177264111, 56461.81303710939, 1205.891469767725, 1269.073576289314, 1288.15625765124, 1331.6005198440623, 1353.8578449262882, 29978.85010574933, 30694.0, 32064.0, 32187.0, 32513.187170320933, 48353.758231208616, 49011.264831028275, 49018.75490622667, 49034.75482622564, 49037.754811225714, 383594.0, 383722.0, 384286.0, 385843.0, 386241.0, 26780.330491737863, 27206.455870882866, 27437.725622743517, 29003.274918127216, 29060.7093929058, 46043.0, 46493.3026004617, 46622.0, 46648.0, 46946.53053469422, 39992.200155996135, 40250.0, 41466.0, 41467.7926610365, 43228.135437291705, 40699.0, 42640.37556807706, 43619.0, 44138.02052141952, 45220.54779452163, 41641.58358416498, 41980.0, 42048.57951420569, 42744.14511709811, 42839.0, 40971.0, 42251.3662295072, 42488.78755606202, 42521.0, 42834.07408147978, 27328.863355683094, 28449.857750711115, 28616.71383286224, 28635.28411789722, 28688.42623147567], "value": 18849.55601894274, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.1029521049773, 374.60666300384605, 383.0825173708966, 385.37761515153034, 417.8224254691757, 14267.286635668213, 14974.0, 18163.638726965477, 18796.812031879675, 18816.059197040144, 18624.534386640342, 18818.90590547049, 18882.905585472086, 19003.144858481366, 19028.80971190291, 4143.544210136883, 5502.80740174093, 5715.914261286084, 5727.57043221758, 5735.713214339266, 4281.35779633056, 6040.426159514839, 6285.02582099773, 6341.841453963665, 6446.967765161167, 6238.376162383771, 6367.458766004896, 6416.390442907917, 6457.9677101614425, 6468.223813142429, 6381.042843573455, 6412.166418365606, 6422.325655806167, 6425.742970281183, 6427.132337134473, 5480.26016487773, 5641.12562552805, 5678.176664383683, 5679.119736440817, 5687.033204355228, 22506.0, 23141.884290578608, 23148.18981335645, 23176.76823231763, 23393.649095263416, 2218.2125345502277, 2316.3630001749484, 2413.9879300603384, 2504.474060447308, 2904.244896326949, 9872.0, 10538.420386878719, 14198.645033874132, 14242.501512447117, 15017.699646007019, 1874.812518748128, 1934.303650685752, 1948.5907959328558, 1965.2826718247736, 2019.9495012624802, 79306.60346698287, 81608.59195704042, 82029.58985205095, 82120.0, 84448.15551844526, 10768.138548916068, 10931.508082136323, 11020.338779673246, 11125.388103654215, 11204.495797689124, 15146.772798408032, 15170.24148792556, 15194.088354698753, 15223.695526089416, 15268.770968435483, 7808.6095695216145, 7915.190107511866, 7988.6804527819395, 8055.711086226176, 8226.670933162606, 7683.9231607683205, 7712.305892469704, 7948.205179482121, 7990.560519171501, 7995.720149794729, 4621.3068039793625, 4651.697639653412, 4698.154332220233, 4713.552212539803, 4768.499307572724, 1926.3546711851407, 1956.6967120096408, 1981.8216360527333, 1988.8607797454329, 1993.1927569334443, 900.4597241654955, 909.4316052467208, 967.192394350711, 987.6740675577042, 991.2763682511807, 17582.91208543949, 19105.90447047756, 19133.13900874436, 19159.32942347039, 19527.0, 932.7201839448138, 933.9813203735887, 944.2068662323544, 957.674390707163, 966.7969726357544, 8238.794030149294, 10111.231538411568, 10652.659434239054, 10712.0, 10819.296745711661, 394529.0, 403249.0, 410686.0, 412394.0, 412429.0, 49938.50061499338, 76910.61544692241, 85631.57184214164, 87168.0, 87225.56387218024, 969.9224062075158, 973.8003709239589, 1001.5442973447064, 1001.8246806808925, 1002.1231422505308, 15984.200789960689, 16578.75131873047, 16717.49847504577, 16826.158692065103, 17053.317867285168, 35154.296914061066, 40848.387274191504, 41052.38421423621, 41148.1770364585, 41174.38238426366, 50791.0, 52468.737656311474, 52708.472915271894, 54531.454685452634, 61319.38680613137, 7938.483998540077, 8205.548694821842, 8535.95732021336, 8698.695545655872, 8733.606987685696, 9138.771530711785, 12414.62756117318, 13141.277229752455, 13288.800667990181, 13334.533291335145, 10474.266801323834, 11195.216334856808, 11203.71990700239, 11260.324380537195, 11282.830757538479, 5024.246363045572, 7933.444658873824, 10769.007733569002, 11037.889621103686, 11677.824832627348, 11056.0, 11059.170562207706, 11198.552057917917, 11518.82721759191, 11838.763224735629, 7269.963650181715, 7746.496477729155, 8481.2366886978, 8509.87235191485, 8957.955210223907, 10970.561177552809, 11343.262687925258, 11415.885841141482, 11595.768084638428, 11599.420028998686], "value": 8995.893042468266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.822228999085, 1423.8319738581654, 1446.855314468553, 1528.5796405988358, 1692.137010124836, 6607.8348041299, 7470.738524151656, 7771.455998080137, 7783.64973576189, 8221.972253468317, 8081.232282933127, 8153.510789352643, 8158.91841081589, 8165.142660020701, 8171.305439037674, 2265.422317309084, 2276.203328834911, 2279.213671283413, 2281.1445707859552, 2289.919852805152, 2236.9217077402295, 2289.5420915816903, 2303.9078436862505, 2306.6194077977116, 2312.5259321839067, 2260.977390226093, 2268.353519247015, 2287.005152758555, 2289.7710228977135, 2291.255342013844, 2167.4039639099215, 2174.1194816099505, 2189.3650841256017, 2189.6715492676067, 2192.8684278943233, 2174.097749433983, 2228.320362289501, 2229.8662080275235, 2235.251190851067, 2235.8770267635273, 7933.286004259644, 8171.223733745344, 8248.628811703487, 8255.215754503313, 8255.752327430188, 5063.291139240509, 5204.29741984831, 5206.635535512516, 5209.817656382046, 5226.7909283628605, 3269.1500209945348, 3337.632860385356, 3340.2317466982486, 3414.8634054637787, 3428.4171690812373, 1094.162965331522, 1098.8626421697288, 1102.3716481605488, 1120.5685810962757, 1151.2516864038441, 11258.887411125948, 11308.151888608387, 11317.434128293553, 11396.202265841395, 11405.54377824886, 4069.2471892699355, 4380.342948557678, 4403.691741578059, 4477.037436951071, 4480.686351955397, 9031.548422578844, 9032.141946515201, 9035.77410564728, 9040.547972601344, 9044.457332560067, 4994.250862370601, 5042.974785126051, 5048.0, 5052.974735126374, 5063.772130254148, 3930.9213815723524, 4055.0673345130785, 4541.455025396974, 4664.510226426244, 4746.38297021385, 3549.2723991581665, 3592.7305452091196, 3650.525431693916, 3678.521792167001, 3704.0, 1122.6519778868576, 1132.8527291452058, 1144.742432952579, 1150.7813515432042, 1158.3802665573878, 878.1789027259533, 884.6682494064726, 887.2148148888151, 894.3832730452767, 922.864876202275, 5351.331083614548, 5480.0, 5502.669839809624, 5524.58565607581, 5680.97159514208, 437.7723583736439, 446.23025281389994, 459.3729559151734, 459.51291630871384, 464.20389032808896, 3687.612800655946, 3799.506064211635, 3808.1050953026015, 3847.4228865670375, 3870.767753934773, 9818.852717209247, 10162.288639795292, 10190.949045254874, 10349.534270957825, 10354.0, 9801.215902727765, 9823.656172033945, 9927.553260103312, 9943.15483183923, 9948.80102397948, 7509.624518774149, 7561.130469995911, 7913.44605877583, 8000.239977202156, 8012.399070069768, 5460.945390546044, 5496.4503549646315, 5560.582956278215, 5565.7217139143695, 5731.283589551306, 9087.36388452802, 9097.636094556408, 9151.450912945245, 9177.265818734351, 9286.442813431217, 9030.36787424874, 9430.19843313326, 9561.760955976157, 9565.90434095678, 9566.282528810507, 5725.0, 5877.23595932526, 6706.429953453816, 6973.5118541701595, 7056.7530136444975, 7545.50954187976, 7888.605569721606, 7901.288884000468, 7912.9208707912185, 7952.880706789519, 7064.752733654297, 7141.9642901785155, 7153.391961683107, 7155.570665760071, 7330.853382932205, 6927.515073944775, 6997.440204783707, 7026.086608740831, 7158.8926166108595, 7167.569945803269, 6730.8653826924165, 6742.5280230383405, 6791.864162716619, 6801.795946121624, 6806.8638627228165, 4788.592969597484, 4890.9021819562695, 4996.975015125046, 5001.499550134872, 5079.492050794891, 4782.569568738831, 4829.637777166657, 4835.758212089452, 4843.467218606021, 5112.948870511247], "value": 4261.525218473875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.9707526322631, 326.5754519125138, 332.8485539079719, 333.7430178762352, 336.3659501839031, 5224.973875130624, 5256.211568264762, 5289.0, 5290.735463226838, 5297.284866543016, 5191.442567229835, 5204.8809505956215, 5234.476552344773, 5246.947530524693, 5260.842174734755, 3875.457435958968, 3953.1303113315025, 4065.4714887064642, 4066.0, 4081.653059489947, 4084.1423301106656, 4095.1400205956784, 4103.7948102594755, 4114.588541145877, 4126.174765046988, 4057.3305404608204, 4058.289799285113, 4071.694622903294, 4084.1627466369473, 4109.342505199169, 3983.6215559521943, 4056.71602987791, 4058.5129784425762, 4069.532003819569, 4086.6730661547153, 3582.3193593217466, 3594.8741794037346, 3597.9100522486888, 3601.1537288737127, 3609.927801443983, 5096.216324286507, 5096.235564665293, 5107.693538387709, 5111.7699703513435, 5117.1556693145585, 4455.22033644111, 4625.699329543569, 4665.6967297125575, 4670.462896766881, 4670.836520721792, 5439.38909323523, 5441.755121019524, 5442.292501974757, 5443.020256353894, 5488.807891723811, 3937.822797974098, 3940.6059394060653, 3954.4661470701662, 3954.9604503955165, 3957.28768821612, 5302.681839089667, 5626.578006649477, 5632.746526406321, 5662.989638678292, 5702.7433765480655, 3962.306596345628, 4005.3377848193254, 4013.4381186633896, 4047.1096358801015, 4047.392891066305, 4064.2684316822665, 4075.836966521306, 4083.1629515949157, 4086.59134086589, 4112.527059388149, 4601.608863246594, 4701.247800351927, 4720.834770783006, 4734.147853386355, 4735.384400027974, 5451.0, 5464.672119672832, 5512.641678290898, 5558.694271815089, 5586.16207568868, 1384.5846246126323, 1393.4356585582855, 1402.975827645804, 1408.4718230663502, 1412.8202950536213, 861.6984055580497, 895.0959530873735, 907.3512438606429, 919.6459363145103, 924.1867156901883, 5162.483751624807, 5236.005159019774, 5306.177542480922, 5358.91961620576, 5360.65155764874, 5657.12314591239, 5658.915116273177, 5674.347450043216, 5677.37548869624, 5681.545476361881, 5173.611979101583, 5265.657732247469, 5297.417284098746, 5347.3048503695045, 5370.355557333145, 2957.31981644223, 2993.9850300748794, 2997.5803387525766, 3003.57949887016, 3008.1426793363785, 5797.144898642356, 5809.838032393538, 5823.94176058234, 5855.272694555117, 5906.734196961061, 5535.8892822144135, 5661.264035675335, 5662.999999999917, 5711.771529138871, 5732.226149469851, 5782.2483077199695, 5809.622374545641, 5824.854378640483, 5826.184334193216, 5842.561807864342, 5348.331458567679, 5505.807296744595, 5606.355269143937, 5633.802816901389, 5688.459596338341, 5545.944540554543, 5547.8890422190525, 5555.30558680165, 5572.275604171432, 5586.553075753849, 5742.28221472316, 5763.135529670583, 5872.442117998783, 5889.793857214977, 5918.556108291809, 3924.7252692312404, 4015.915702760297, 4045.8988525287104, 4053.2704113259897, 4058.3912413138264, 5644.887102258014, 5646.88706225865, 5660.29246344207, 5667.5465962722055, 5671.517920976763, 5500.202470641814, 5516.14499752539, 5533.841801697261, 5545.916811247916, 5570.080936645571, 5228.241904923841, 5450.618456707993, 5496.5053145217125, 5508.531774799187, 5534.1975413565615, 5425.511703946506, 5437.374701909331, 5438.18427235902, 5451.236826844166, 5484.327280179424, 5358.517733404013, 5373.382061062872, 5438.320209973754, 5441.775600489858, 5480.671159730429, 5351.732413379394, 5353.732313384237, 5354.491323324278, 5368.0, 5386.973065134649], "value": 4186.028563611741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.392454639917, 694.1878002736804, 730.9451791115667, 767.8310771630242, 789.8262382275901, 13486.865131348684, 14642.121472711644, 14663.706725865477, 14795.85204147957, 14825.703485930275, 13666.658333541667, 13900.026998110136, 13908.721825563483, 13938.651533711636, 13944.860551394482, 636.8980963045914, 655.6688872119573, 758.9241075892422, 764.7782143178472, 782.5031105248152, 783.396784475956, 784.9529028258294, 785.4030936488253, 785.446260386429, 785.5522352259214, 819.6516480495795, 821.2936874288107, 821.322409012564, 821.7452589697212, 821.7534739578102, 661.8709351676425, 680.8195828105556, 682.0451368084696, 682.2290811383106, 813.8250276190618, 587.5886879184588, 601.5247954116243, 605.503487140545, 606.7118118893491, 607.2530787131852, 13229.140105893086, 13229.470821167142, 13246.47014119434, 13255.734885302336, 13260.73478530424, 12908.935455322757, 13192.604221873358, 13334.599962001059, 13384.598462046155, 13519.797203041962, 11562.07503399726, 11618.128640352008, 11655.825162622483, 11987.160898737093, 12071.818922716166, 4203.4115223868685, 4234.830606775725, 4252.128313695685, 4348.478182618106, 4385.978070109661, 58742.0, 59025.7048714758, 60286.69856650732, 62180.37819621791, 62897.0, 10755.193360497993, 10849.186311026704, 10859.07697845692, 10859.131269498579, 10928.83663982325, 19691.11389987454, 19930.800691993183, 19977.600447990957, 19982.20071197165, 19983.900080499505, 7252.2385149559595, 7267.309481854005, 7366.668499917517, 7462.365698915544, 7463.10442746863, 4364.258076127066, 4373.825046998148, 4424.13729322779, 4430.867073987785, 4454.888627784267, 2892.971070289312, 3001.3847161331873, 3003.804752691068, 3004.6094007778847, 3006.969930300669, 547.4361407750024, 553.883684426275, 554.2849723856181, 564.1678524176806, 564.6668465605312, 610.3469287861946, 613.1232337756961, 632.8924082905917, 642.948564114879, 642.9774957876452, 8032.638531266107, 8599.355048371397, 8606.87089693655, 8798.076201998698, 8977.596008179517, 633.1578999930082, 633.6261605652687, 634.4099987012123, 640.7853369121397, 641.9261784894796, 4027.3354896442347, 4175.979120104441, 4178.456800615901, 4281.571842815693, 4379.759113248738, 52187.0, 59001.114983275285, 83527.0, 84468.59130712939, 88443.55778221067, 64149.67925160344, 76666.0, 77245.61377193077, 79561.0, 82208.0, 55439.0, 60351.698241508515, 61983.0, 62110.689446552475, 62524.0, 9411.858822117536, 9836.852447213441, 9872.35829671069, 9943.900560994298, 10000.749981250236, 38951.80524097361, 40293.39559906662, 41698.791506042275, 41883.581164189185, 45246.77376613096, 54286.82852685848, 59289.0, 59307.883054033795, 59833.700831497306, 63042.36957630365, 11585.826212606986, 11684.766304673689, 11906.583269585522, 12328.137030407785, 12457.563985260473, 12817.0, 12857.614271571867, 12981.610551683465, 13524.39140238672, 13620.250886201355, 11871.762564748484, 11950.581729639422, 12181.269123852597, 12271.0, 12460.501579936701, 12106.515739370327, 12248.203866748632, 12313.891749742566, 12635.115541911979, 13564.0, 12097.939510302393, 12134.211276267015, 12540.937295313464, 12617.621471355875, 12640.178388404724, 10652.62715804943, 10669.50520481968, 11050.115990720884, 11050.668479945614, 11199.0, 10926.344419334866, 10936.835947460635, 10977.89860993489, 11015.504302306575, 11021.669349919515], "value": 6765.715171126627, "unit": "score"}], "name": "dromaeo_css", "value": 6901.42812028187, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 121.0, 156.0, 126.0, 128.0, 129.0, 120.0, 156.0, 126.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 164.0, 160.0, 161.0, 160.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 110.0, 76.0, 76.0, 77.0, 76.0, 101.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 106.0, 83.0, 83.0, 84.0, 101.0, 83.0, 83.0, 114.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 54.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 80.0, 87.0, 80.0, 79.0, 88.0, 81.0, 85.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 134.0, 130.0, 134.0, 133.0, 138.0, 136.0, 171.0, 144.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 170.0, 170.0, 172.0, 172.0, 166.0, 166.0, 173.0, 167.0, 173.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 74.0, 64.0, 65.0, 64.0, 64.0, 67.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1499.6, "alertThreshold": 2.0}]} 10:34:57 INFO - Return code: 0 10:34:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:34:57 INFO - # TBPL SUCCESS # 10:34:57 INFO - Running post-action listener: _resource_record_post_action 10:34:57 INFO - [mozharness: 2016-11-04 17:34:57.337957Z] Finished run-tests step (success) 10:34:57 INFO - Running post-run listener: _resource_record_post_run 10:34:57 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8093696; Write bytes: 422182912; Read time: 1836; Write time: 387944 10:34:57 INFO - TinderboxPrint: CPU usage
13.0% 10:34:57 INFO - TinderboxPrint: I/O read bytes / time
8,093,696 / 1,836 10:34:57 INFO - TinderboxPrint: I/O write bytes / time
422,182,912 / 387,944 10:34:57 INFO - TinderboxPrint: CPU idle
8,324.3 (86.9%) 10:34:57 INFO - TinderboxPrint: CPU user
1,195.2 (12.5%) 10:34:57 INFO - TinderboxPrint: Swap in / out
0 / 0 10:34:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4472832; Read time: 0; Write time: 316 10:34:57 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5881856; Write bytes: 363954176; Read time: 1500; Write time: 360612 10:34:57 INFO - Running post-run listener: _upload_blobber_files 10:34:57 INFO - Blob upload gear active. 10:34:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:57 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 10:34:57 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'] 10:34:57 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 10:34:58 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:01 INFO - (blobuploader) - INFO - Done attempting. 10:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:02 INFO - (blobuploader) - INFO - Done attempting. 10:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:03 INFO - (blobuploader) - INFO - Done attempting. 10:35:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:03 INFO - Return code: 0 10:35:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2b4e76d0b2cc4c61107fef379744a9643d214c5f0f7ea8efae41e3e59a3b8e21cec6772c6e080f1dae9cacd9bd4b6464a03eb50d14969277ecb2fba3e01615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a0199580aa102a4b38082c9d7869d663ee42ace7503f9566df895c32493ba7c1e4d4560e56cf294e3c2a2c7fdfb684b9184b0174b0d8b79b9fe9bb7b16f598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44016395d0fd3592ffea2d34871627b51ddeff6cc8e21f130066b005431679e453986737b6d69c267eb78c797e235693bc33e034ab3a2bf87e3b756beda039a"} 10:35:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:03 INFO - Contents: 10:35:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2b4e76d0b2cc4c61107fef379744a9643d214c5f0f7ea8efae41e3e59a3b8e21cec6772c6e080f1dae9cacd9bd4b6464a03eb50d14969277ecb2fba3e01615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a0199580aa102a4b38082c9d7869d663ee42ace7503f9566df895c32493ba7c1e4d4560e56cf294e3c2a2c7fdfb684b9184b0174b0d8b79b9fe9bb7b16f598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44016395d0fd3592ffea2d34871627b51ddeff6cc8e21f130066b005431679e453986737b6d69c267eb78c797e235693bc33e034ab3a2bf87e3b756beda039a"} 10:35:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:03 INFO - Copying logs to upload dir... 10:35:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.492583 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-04 10:35:03.218519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 10:35:03.223692) ========= 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=32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2b4e76d0b2cc4c61107fef379744a9643d214c5f0f7ea8efae41e3e59a3b8e21cec6772c6e080f1dae9cacd9bd4b6464a03eb50d14969277ecb2fba3e01615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a0199580aa102a4b38082c9d7869d663ee42ace7503f9566df895c32493ba7c1e4d4560e56cf294e3c2a2c7fdfb684b9184b0174b0d8b79b9fe9bb7b16f598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44016395d0fd3592ffea2d34871627b51ddeff6cc8e21f130066b005431679e453986737b6d69c267eb78c797e235693bc33e034ab3a2bf87e3b756beda039a"} build_url:https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/Xb57EXvnQeKzaja6p9tp_A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2b4e76d0b2cc4c61107fef379744a9643d214c5f0f7ea8efae41e3e59a3b8e21cec6772c6e080f1dae9cacd9bd4b6464a03eb50d14969277ecb2fba3e01615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a0199580aa102a4b38082c9d7869d663ee42ace7503f9566df895c32493ba7c1e4d4560e56cf294e3c2a2c7fdfb684b9184b0174b0d8b79b9fe9bb7b16f598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e44016395d0fd3592ffea2d34871627b51ddeff6cc8e21f130066b005431679e453986737b6d69c267eb78c797e235693bc33e034ab3a2bf87e3b756beda039a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 10:35:03.249835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:35:03.250246) ========= 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=32c5991c409366f7fec8a718000001d2-1478279653.534401-1353513043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 10:35:03.333164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 10:35:03.333496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 10:35:03.333820) ========= ========= Total master_lag: 0.53 =========