builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1475561768.48 results: success (0) buildid: 20161003213045 builduid: 050004a692aa4a1bb3fafeb04fc291f8 revision: 625a597ea7e3557d18487cf1616eb599f8ba34a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.476886) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.477236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.477499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.491952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.492221) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 23:16:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-10-03 23:16:08 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.621130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.621412) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017393 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.671197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:08.671536) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 625a597ea7e3557d18487cf1616eb599f8ba34a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 625a597ea7e3557d18487cf1616eb599f8ba34a2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 23:16:08,923 truncating revision to first 12 chars 2016-10-03 23:16:08,923 Setting DEBUG logging. 2016-10-03 23:16:08,923 attempt 1/10 2016-10-03 23:16:08,923 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/625a597ea7e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 23:16:09,223 unpacking tar archive at: mozilla-inbound-625a597ea7e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:09.361005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:09.361287) ========= script_repo_revision: 625a597ea7e3557d18487cf1616eb599f8ba34a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:09.361688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:09.361952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:09.369814) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-03 23:16:09.370179) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:16:09 INFO - MultiFileLogger online at 20161003 23:16:09 in /builds/slave/test 23:16:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 23:16:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:16:09 INFO - {'append_to_log': False, 23:16:09 INFO - 'base_work_dir': '/builds/slave/test', 23:16:09 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 23:16:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:16:09 INFO - 'branch': 'Mozilla-Inbound', 23:16:09 INFO - 'buildbot_json_path': 'buildprops.json', 23:16:09 INFO - 'config_files': ('talos/linux_config.py',), 23:16:09 INFO - 'default_actions': ('clobber', 23:16:09 INFO - 'read-buildbot-config', 23:16:09 INFO - 'download-and-extract', 23:16:09 INFO - 'populate-webroot', 23:16:09 INFO - 'create-virtualenv', 23:16:09 INFO - 'install', 23:16:09 INFO - 'run-tests'), 23:16:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:16:09 INFO - 'download_minidump_stackwalk': True, 23:16:09 INFO - 'download_symbols': 'ondemand', 23:16:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:16:09 INFO - 'tooltool.py': '/tools/tooltool.py', 23:16:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:16:09 INFO - '/tools/misc-python/virtualenv.py')}, 23:16:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:16:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:16:09 INFO - 'installer_path': 'installer.exe', 23:16:09 INFO - 'log_level': 'info', 23:16:09 INFO - 'log_name': 'talos', 23:16:09 INFO - 'log_to_console': True, 23:16:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:16:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:16:09 INFO - 'opt_config_files': (), 23:16:09 INFO - 'pip_index': False, 23:16:09 INFO - 'sps_profile': False, 23:16:09 INFO - 'sps_profile_interval': 0, 23:16:09 INFO - 'suite': 'dromaeojs', 23:16:09 INFO - 'system_bits': '32', 23:16:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:16:09 INFO - 'title': 'talos-linux64-ix-049', 23:16:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:16:09 INFO - 'use_talos_json': True, 23:16:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:16:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:16:09 INFO - 'work_dir': 'build'} 23:16:09 INFO - [mozharness: 2016-10-04 06:16:09.718986Z] Running clobber step. 23:16:09 INFO - Running pre-action listener: _resource_record_pre_action 23:16:09 INFO - Running main action method: clobber 23:16:09 INFO - rmtree: /builds/slave/test/build 23:16:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:16:10 INFO - Running post-action listener: _resource_record_post_action 23:16:10 INFO - [mozharness: 2016-10-04 06:16:10.703874Z] Finished clobber step (success) 23:16:10 INFO - [mozharness: 2016-10-04 06:16:10.703972Z] Running read-buildbot-config step. 23:16:10 INFO - Running pre-action listener: _resource_record_pre_action 23:16:10 INFO - Running main action method: read_buildbot_config 23:16:10 INFO - Using buildbot properties: 23:16:10 INFO - { 23:16:10 INFO - "project": "", 23:16:10 INFO - "product": "firefox", 23:16:10 INFO - "script_repo_revision": "production", 23:16:10 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 23:16:10 INFO - "repository": "", 23:16:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 23:16:10 INFO - "buildid": "20161003213045", 23:16:10 INFO - "pgo_build": "True", 23:16:10 INFO - "basedir": "/builds/slave/test", 23:16:10 INFO - "buildnumber": 2527, 23:16:10 INFO - "slavename": "talos-linux64-ix-049", 23:16:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:16:10 INFO - "platform": "ubuntu64_hw", 23:16:10 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 23:16:10 INFO - "branch": "mozilla-inbound", 23:16:10 INFO - "repo_path": "integration/mozilla-inbound", 23:16:10 INFO - "revision": "625a597ea7e3557d18487cf1616eb599f8ba34a2", 23:16:10 INFO - "stage_platform": "linux64-pgo", 23:16:10 INFO - "builduid": "050004a692aa4a1bb3fafeb04fc291f8", 23:16:10 INFO - "slavebuilddir": "test" 23:16:10 INFO - } 23:16:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:16:10 INFO - Running post-action listener: _resource_record_post_action 23:16:10 INFO - [mozharness: 2016-10-04 06:16:10.706354Z] Finished read-buildbot-config step (success) 23:16:10 INFO - [mozharness: 2016-10-04 06:16:10.706450Z] Running download-and-extract step. 23:16:10 INFO - Running pre-action listener: _resource_record_pre_action 23:16:10 INFO - Running main action method: download_and_extract 23:16:10 INFO - mkdir: /builds/slave/test/build/tests 23:16:10 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')]} 23:16:10 INFO - trying https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:16:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/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 23:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/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 23:16:11 INFO - Downloaded 1361 bytes. 23:16:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:16:11 INFO - Using the following test package requirements: 23:16:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'jsshell-linux-x86_64.zip'], 23:16:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:16:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:16:11 INFO - Http code: 200 23:16:11 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 23:16:11 INFO - x-amz-cf-id: wZvYaJ7rnpJsYo0U5KwbaQ7K9hpAyNayX_JogechBHyZKtSc9f6F0g== 23:16:11 INFO - x-amz-version-id: SzYLsHHEALlygV6ggL55KULqWP163C.B 23:16:12 INFO - Expected file size: 21992701 23:16:12 INFO - Obtained file size: 21992701 23:16:16 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 23:16:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:16:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:16:16 INFO - Http code: 200 23:16:16 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 23:16:16 INFO - x-amz-cf-id: 7eiNYB6PGnGZLdxy77PmHFwYeMRv9KVJRxMBfLu0INHX0xq4prFO7w== 23:16:16 INFO - x-amz-version-id: SzYLsHHEALlygV6ggL55KULqWP163C.B 23:16:17 INFO - Expected file size: 21992701 23:16:17 INFO - Obtained file size: 21992701 23:16:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:16:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:16:22 INFO - Http code: 200 23:16:22 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 23:16:22 INFO - x-amz-cf-id: 1uQRCKmBX5Ex70Xkds6kTqMFVcGE2OuVEZNnJXCePoZm0wJN3ytQMQ== 23:16:22 INFO - x-amz-version-id: KsUa6fmB3bngoQiaLNX7nFq4m8ICKT7Y 23:16:22 INFO - Expected file size: 14408522 23:16:22 INFO - Obtained file size: 14408522 23:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:22 INFO - trying https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/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 23:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/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 23:16:23 INFO - Downloaded 59687696 bytes. 23:16:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:23 INFO - mkdir: /builds/slave/test/properties 23:16:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:16:23 INFO - Writing to file /builds/slave/test/properties/build_url 23:16:23 INFO - Contents: 23:16:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:24 INFO - Running post-action listener: _resource_record_post_action 23:16:24 INFO - Running post-action listener: set_extra_try_arguments 23:16:24 INFO - [mozharness: 2016-10-04 06:16:24.723330Z] Finished download-and-extract step (success) 23:16:24 INFO - [mozharness: 2016-10-04 06:16:24.723554Z] Running populate-webroot step. 23:16:24 INFO - Running pre-action listener: _resource_record_pre_action 23:16:24 INFO - Running main action method: populate_webroot 23:16:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:16:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:16:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:16:24 INFO - '--tppagecycles', 23:16:24 INFO - '7'], 23:16:24 INFO - 'tests': ['tsvgm']}}, 23:16:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:16:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:16:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:16:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:16:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['damp', 'tps']}, 23:16:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'tests': ['damp', 'tps']}, 23:16:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['dromaeo_dom']}, 23:16:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:16:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['basic_compositor_video']}, 23:16:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:16:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['a11yr', 23:16:24 INFO - 'ts_paint', 23:16:24 INFO - 'tpaint', 23:16:24 INFO - 'sessionrestore', 23:16:24 INFO - 'sessionrestore_no_auto_restore', 23:16:24 INFO - 'tabpaint']}, 23:16:24 INFO - 'other-e10s': {'tests': ['a11yr', 23:16:24 INFO - 'ts_paint', 23:16:24 INFO - 'tpaint', 23:16:24 INFO - 'sessionrestore', 23:16:24 INFO - 'sessionrestore_no_auto_restore', 23:16:24 INFO - 'tabpaint']}, 23:16:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:16:24 INFO - 'ts_paint', 23:16:24 INFO - 'tpaint', 23:16:24 INFO - 'sessionrestore', 23:16:24 INFO - 'sessionrestore_no_auto_restore', 23:16:24 INFO - 'tabpaint']}, 23:16:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:16:24 INFO - 'ts_paint', 23:16:24 INFO - 'tpaint', 23:16:24 INFO - 'sessionrestore', 23:16:24 INFO - 'sessionrestore_no_auto_restore', 23:16:24 INFO - 'tabpaint']}, 23:16:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['a11yr', 23:16:24 INFO - 'ts_paint', 23:16:24 INFO - 'tpaint', 23:16:24 INFO - 'sessionrestore', 23:16:24 INFO - 'sessionrestore_no_auto_restore', 23:16:24 INFO - 'tabpaint']}, 23:16:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['a11yr', 23:16:24 INFO - 'ts_paint', 23:16:24 INFO - 'tpaint', 23:16:24 INFO - 'sessionrestore', 23:16:24 INFO - 'sessionrestore_no_auto_restore', 23:16:24 INFO - 'tabpaint']}, 23:16:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['tsvgx', 23:16:24 INFO - 'tsvgr_opacity', 23:16:24 INFO - 'tart', 23:16:24 INFO - 'tscrollx', 23:16:24 INFO - 'cart']}, 23:16:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:16:24 INFO - 'tsvgr_opacity', 23:16:24 INFO - 'tart', 23:16:24 INFO - 'tscrollx', 23:16:24 INFO - 'cart']}, 23:16:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'talos_options': ['--disable-e10s'], 23:16:24 INFO - 'tests': ['tp5o']}, 23:16:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'tests': ['tp5o']}, 23:16:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'talos_options': ['--disable-e10s', 23:16:24 INFO - '--xperf_path', 23:16:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:24 INFO - 'tests': ['tp5n']}, 23:16:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:24 INFO - 'talos_options': ['--xperf_path', 23:16:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:24 INFO - 'tests': ['tp5n']}}, 23:16:24 INFO - 'talos.zip': {'path': '', 23:16:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:16:24 INFO - Running post-action listener: _resource_record_post_action 23:16:24 INFO - [mozharness: 2016-10-04 06:16:24.738658Z] Finished populate-webroot step (success) 23:16:24 INFO - [mozharness: 2016-10-04 06:16:24.738745Z] Running create-virtualenv step. 23:16:24 INFO - Running pre-action listener: _resource_record_pre_action 23:16:24 INFO - Running main action method: create_virtualenv 23:16:24 INFO - Creating virtualenv /builds/slave/test/build/venv 23:16:24 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 23:16:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:16:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:16:24 INFO - Using real prefix '/usr' 23:16:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:16:25 INFO - Installing distribute.............................................................................................................................................................................................done. 23:16:27 INFO - Installing pip.................done. 23:16:27 INFO - Return code: 0 23:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:16:27 INFO - Reading from file tmpfile_stdout 23:16:27 INFO - Output received: 23:16:27 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) 23:16:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:16:27 INFO - Using env: {'DISPLAY': ':0', 23:16:27 INFO - 'HOME': '/home/cltbld', 23:16:27 INFO - 'LANG': 'en_US.UTF-8', 23:16:27 INFO - 'LANGUAGE': 'en_US:en', 23:16:27 INFO - 'LOGNAME': 'cltbld', 23:16:27 INFO - 'MAIL': '/var/mail/cltbld', 23:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:27 INFO - 'MOZ_NO_REMOTE': '1', 23:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:27 INFO - 'NO_EM_RESTART': '1', 23:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:27 INFO - 'PWD': '/builds/slave/test', 23:16:27 INFO - 'SHELL': '/bin/bash', 23:16:27 INFO - 'SHLVL': '1', 23:16:27 INFO - 'TERM': 'linux', 23:16:27 INFO - 'TMOUT': '86400', 23:16:27 INFO - 'USER': 'cltbld', 23:16:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:27 INFO - '_': '/tools/buildbot/bin/python'} 23:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:27 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 23:16:27 INFO - Cleaning up... 23:16:27 INFO - Return code: 0 23:16:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:16:27 INFO - Using env: {'DISPLAY': ':0', 23:16:27 INFO - 'HOME': '/home/cltbld', 23:16:27 INFO - 'LANG': 'en_US.UTF-8', 23:16:27 INFO - 'LANGUAGE': 'en_US:en', 23:16:27 INFO - 'LOGNAME': 'cltbld', 23:16:27 INFO - 'MAIL': '/var/mail/cltbld', 23:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:27 INFO - 'MOZ_NO_REMOTE': '1', 23:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:27 INFO - 'NO_EM_RESTART': '1', 23:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:27 INFO - 'PWD': '/builds/slave/test', 23:16:27 INFO - 'SHELL': '/bin/bash', 23:16:27 INFO - 'SHLVL': '1', 23:16:27 INFO - 'TERM': 'linux', 23:16:27 INFO - 'TMOUT': '86400', 23:16:27 INFO - 'USER': 'cltbld', 23:16:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:27 INFO - '_': '/tools/buildbot/bin/python'} 23:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:27 INFO - Downloading/unpacking psutil>=3.1.1 23:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:16:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:30 INFO - Installing collected packages: psutil 23:16:30 INFO - Running setup.py install for psutil 23:16:30 INFO - building 'psutil._psutil_linux' extension 23:16:30 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 23:16:30 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 23:16:30 INFO - building 'psutil._psutil_posix' extension 23:16:30 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 23:16:30 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 23:16:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:30 INFO - Successfully installed psutil 23:16:30 INFO - Cleaning up... 23:16:30 INFO - Return code: 0 23:16:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:16:30 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')]} 23:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:30 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')]} 23:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:30 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:30 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 23:16:30 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 23:16:30 INFO - Using env: {'DISPLAY': ':0', 23:16:30 INFO - 'HOME': '/home/cltbld', 23:16:30 INFO - 'LANG': 'en_US.UTF-8', 23:16:30 INFO - 'LANGUAGE': 'en_US:en', 23:16:30 INFO - 'LOGNAME': 'cltbld', 23:16:30 INFO - 'MAIL': '/var/mail/cltbld', 23:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:30 INFO - 'MOZ_NO_REMOTE': '1', 23:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:30 INFO - 'NO_EM_RESTART': '1', 23:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:30 INFO - 'PWD': '/builds/slave/test', 23:16:30 INFO - 'SHELL': '/bin/bash', 23:16:30 INFO - 'SHLVL': '1', 23:16:30 INFO - 'TERM': 'linux', 23:16:30 INFO - 'TMOUT': '86400', 23:16:30 INFO - 'USER': 'cltbld', 23:16:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:30 INFO - '_': '/tools/buildbot/bin/python'} 23:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:16:32 INFO - Installing collected packages: mozsystemmonitor 23:16:32 INFO - Running setup.py install for mozsystemmonitor 23:16:32 INFO - Successfully installed mozsystemmonitor 23:16:32 INFO - Cleaning up... 23:16:33 INFO - Return code: 0 23:16:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:16:33 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')]} 23:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:33 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')]} 23:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:33 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:33 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 23:16:33 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 23:16:33 INFO - Using env: {'DISPLAY': ':0', 23:16:33 INFO - 'HOME': '/home/cltbld', 23:16:33 INFO - 'LANG': 'en_US.UTF-8', 23:16:33 INFO - 'LANGUAGE': 'en_US:en', 23:16:33 INFO - 'LOGNAME': 'cltbld', 23:16:33 INFO - 'MAIL': '/var/mail/cltbld', 23:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:33 INFO - 'MOZ_NO_REMOTE': '1', 23:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:33 INFO - 'NO_EM_RESTART': '1', 23:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:33 INFO - 'PWD': '/builds/slave/test', 23:16:33 INFO - 'SHELL': '/bin/bash', 23:16:33 INFO - 'SHLVL': '1', 23:16:33 INFO - 'TERM': 'linux', 23:16:33 INFO - 'TMOUT': '86400', 23:16:33 INFO - 'USER': 'cltbld', 23:16:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:33 INFO - '_': '/tools/buildbot/bin/python'} 23:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:33 INFO - Downloading/unpacking jsonschema==2.5.1 23:16:33 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 23:16:33 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 23:16:33 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 23:16:33 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 23:16:33 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 23:16:33 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 23:16:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:16:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:35 INFO - Downloading functools32-3.2.3-2.tar.gz 23:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:16:35 INFO - warning: no files found matching '*.txt' 23:16:35 INFO - no previously-included directories found matching 'build' 23:16:35 INFO - no previously-included directories found matching 'dist' 23:16:35 INFO - no previously-included directories found matching '.git*' 23:16:35 INFO - Installing collected packages: jsonschema, functools32 23:16:35 INFO - Running setup.py install for functools32 23:16:35 INFO - warning: no files found matching '*.txt' 23:16:35 INFO - no previously-included directories found matching 'build' 23:16:35 INFO - no previously-included directories found matching 'dist' 23:16:35 INFO - no previously-included directories found matching '.git*' 23:16:35 INFO - Successfully installed jsonschema functools32 23:16:35 INFO - Cleaning up... 23:16:35 INFO - Return code: 0 23:16:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:35 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 23:16:35 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 23:16:35 INFO - Using env: {'DISPLAY': ':0', 23:16:35 INFO - 'HOME': '/home/cltbld', 23:16:35 INFO - 'LANG': 'en_US.UTF-8', 23:16:35 INFO - 'LANGUAGE': 'en_US:en', 23:16:35 INFO - 'LOGNAME': 'cltbld', 23:16:35 INFO - 'MAIL': '/var/mail/cltbld', 23:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:35 INFO - 'MOZ_NO_REMOTE': '1', 23:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:35 INFO - 'NO_EM_RESTART': '1', 23:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:35 INFO - 'PWD': '/builds/slave/test', 23:16:35 INFO - 'SHELL': '/bin/bash', 23:16:35 INFO - 'SHLVL': '1', 23:16:35 INFO - 'TERM': 'linux', 23:16:35 INFO - 'TMOUT': '86400', 23:16:35 INFO - 'USER': 'cltbld', 23:16:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:35 INFO - '_': '/tools/buildbot/bin/python'} 23:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:16:35 INFO - Cleaning up... 23:16:35 INFO - Return code: 0 23:16:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:35 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 23:16:35 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 23:16:35 INFO - Using env: {'DISPLAY': ':0', 23:16:35 INFO - 'HOME': '/home/cltbld', 23:16:35 INFO - 'LANG': 'en_US.UTF-8', 23:16:35 INFO - 'LANGUAGE': 'en_US:en', 23:16:35 INFO - 'LOGNAME': 'cltbld', 23:16:35 INFO - 'MAIL': '/var/mail/cltbld', 23:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:35 INFO - 'MOZ_NO_REMOTE': '1', 23:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:35 INFO - 'NO_EM_RESTART': '1', 23:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:35 INFO - 'PWD': '/builds/slave/test', 23:16:35 INFO - 'SHELL': '/bin/bash', 23:16:35 INFO - 'SHLVL': '1', 23:16:35 INFO - 'TERM': 'linux', 23:16:35 INFO - 'TMOUT': '86400', 23:16:35 INFO - 'USER': 'cltbld', 23:16:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:35 INFO - '_': '/tools/buildbot/bin/python'} 23:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:36 INFO - Downloading/unpacking blobuploader==1.2.4 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:38 INFO - Downloading blobuploader-1.2.4.tar.gz 23:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:16:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:16:38 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 23:16:38 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 23:16:38 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 23:16:38 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 23:16:38 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 23:16:38 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 23:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:16:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:39 INFO - Downloading docopt-0.6.1.tar.gz 23:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:39 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:39 INFO - Running setup.py install for blobuploader 23:16:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:39 INFO - Running setup.py install for requests 23:16:40 INFO - Running setup.py install for docopt 23:16:40 INFO - Successfully installed blobuploader requests docopt 23:16:40 INFO - Cleaning up... 23:16:40 INFO - Return code: 0 23:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:40 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:40 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 23:16:40 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 23:16:40 INFO - Using env: {'DISPLAY': ':0', 23:16:40 INFO - 'HOME': '/home/cltbld', 23:16:40 INFO - 'LANG': 'en_US.UTF-8', 23:16:40 INFO - 'LANGUAGE': 'en_US:en', 23:16:40 INFO - 'LOGNAME': 'cltbld', 23:16:40 INFO - 'MAIL': '/var/mail/cltbld', 23:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:40 INFO - 'MOZ_NO_REMOTE': '1', 23:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:40 INFO - 'NO_EM_RESTART': '1', 23:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:40 INFO - 'PWD': '/builds/slave/test', 23:16:40 INFO - 'SHELL': '/bin/bash', 23:16:40 INFO - 'SHLVL': '1', 23:16:40 INFO - 'TERM': 'linux', 23:16:40 INFO - 'TMOUT': '86400', 23:16:40 INFO - 'USER': 'cltbld', 23:16:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:40 INFO - '_': '/tools/buildbot/bin/python'} 23:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:40 INFO - Running setup.py (path:/tmp/pip-EU9VwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:40 INFO - Running setup.py (path:/tmp/pip-BjNWWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:40 INFO - Running setup.py (path:/tmp/pip-OIYlrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:40 INFO - Running setup.py (path:/tmp/pip-VYELgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:40 INFO - Running setup.py (path:/tmp/pip-l8Ihux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:41 INFO - Running setup.py (path:/tmp/pip-pT4kZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:41 INFO - Running setup.py (path:/tmp/pip-pFdMIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:41 INFO - Running setup.py (path:/tmp/pip-O1WODA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:41 INFO - Running setup.py (path:/tmp/pip-OYkDfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:41 INFO - Running setup.py (path:/tmp/pip-NH5wgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:41 INFO - Running setup.py (path:/tmp/pip-64g7WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:41 INFO - Running setup.py (path:/tmp/pip-rRsJkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:41 INFO - Running setup.py (path:/tmp/pip-o37gJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:41 INFO - Running setup.py (path:/tmp/pip-L9QEc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:41 INFO - Running setup.py (path:/tmp/pip-jksYg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:41 INFO - Running setup.py (path:/tmp/pip-gDqfZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:41 INFO - Running setup.py (path:/tmp/pip-XbShp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:41 INFO - Running setup.py install for manifestparser 23:16:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Running setup.py install for mozcrash 23:16:42 INFO - Running setup.py install for mozdebug 23:16:42 INFO - Running setup.py install for mozdevice 23:16:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Running setup.py install for mozfile 23:16:42 INFO - Running setup.py install for mozhttpd 23:16:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Running setup.py install for mozinfo 23:16:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Running setup.py install for mozInstall 23:16:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Running setup.py install for mozleak 23:16:42 INFO - Running setup.py install for mozlog 23:16:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:42 INFO - Running setup.py install for moznetwork 23:16:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:43 INFO - Running setup.py install for mozprocess 23:16:43 INFO - Running setup.py install for mozprofile 23:16:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:43 INFO - Running setup.py install for mozrunner 23:16:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:43 INFO - Running setup.py install for mozscreenshot 23:16:43 INFO - Running setup.py install for moztest 23:16:43 INFO - Running setup.py install for mozversion 23:16:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:43 INFO - Cleaning up... 23:16:43 INFO - Return code: 0 23:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:43 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')]} 23:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:43 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')]} 23:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:43 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:43 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 23:16:43 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 23:16:43 INFO - Using env: {'DISPLAY': ':0', 23:16:43 INFO - 'HOME': '/home/cltbld', 23:16:43 INFO - 'LANG': 'en_US.UTF-8', 23:16:43 INFO - 'LANGUAGE': 'en_US:en', 23:16:43 INFO - 'LOGNAME': 'cltbld', 23:16:43 INFO - 'MAIL': '/var/mail/cltbld', 23:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:43 INFO - 'MOZ_NO_REMOTE': '1', 23:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:43 INFO - 'NO_EM_RESTART': '1', 23:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:43 INFO - 'PWD': '/builds/slave/test', 23:16:43 INFO - 'SHELL': '/bin/bash', 23:16:43 INFO - 'SHLVL': '1', 23:16:43 INFO - 'TERM': 'linux', 23:16:43 INFO - 'TMOUT': '86400', 23:16:43 INFO - 'USER': 'cltbld', 23:16:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:43 INFO - '_': '/tools/buildbot/bin/python'} 23:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:43 INFO - Running setup.py (path:/tmp/pip-b0cqwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:44 INFO - Running setup.py (path:/tmp/pip-c4jKaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:44 INFO - Running setup.py (path:/tmp/pip-AZ7SAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:44 INFO - Running setup.py (path:/tmp/pip-dT8fQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:44 INFO - Running setup.py (path:/tmp/pip-jyuZJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:44 INFO - Running setup.py (path:/tmp/pip-IFx2L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:44 INFO - Running setup.py (path:/tmp/pip-lEP_r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:44 INFO - Running setup.py (path:/tmp/pip-kP0rN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:44 INFO - Running setup.py (path:/tmp/pip-P1aY_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:44 INFO - Running setup.py (path:/tmp/pip-RF24YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:44 INFO - Running setup.py (path:/tmp/pip-POgcDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:44 INFO - Running setup.py (path:/tmp/pip-Z5Uzzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:44 INFO - Running setup.py (path:/tmp/pip-nqwn5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:44 INFO - Running setup.py (path:/tmp/pip-402Bi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:44 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)) 23:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:44 INFO - Running setup.py (path:/tmp/pip-Nswp9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:45 INFO - Running setup.py (path:/tmp/pip-thky9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:45 INFO - Running setup.py (path:/tmp/pip-AnweTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:16:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:47 INFO - Downloading blessings-1.6.tar.gz 23:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:16:47 INFO - Installing collected packages: blessings 23:16:47 INFO - Running setup.py install for blessings 23:16:47 INFO - Successfully installed blessings 23:16:47 INFO - Cleaning up... 23:16:47 INFO - Return code: 0 23:16:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:16:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:47 INFO - Reading from file tmpfile_stdout 23:16:47 INFO - Current package versions: 23:16:47 INFO - argparse == 1.2.1 23:16:47 INFO - blessings == 1.6 23:16:47 INFO - blobuploader == 1.2.4 23:16:47 INFO - docopt == 0.6.1 23:16:47 INFO - functools32 == 3.2.3-2 23:16:47 INFO - jsonschema == 2.5.1 23:16:47 INFO - manifestparser == 1.1 23:16:47 INFO - mozInstall == 1.12 23:16:47 INFO - mozcrash == 0.17 23:16:47 INFO - mozdebug == 0.1 23:16:47 INFO - mozdevice == 0.48 23:16:47 INFO - mozfile == 1.2 23:16:47 INFO - mozhttpd == 0.7 23:16:47 INFO - mozinfo == 0.9 23:16:47 INFO - mozleak == 0.1 23:16:47 INFO - mozlog == 3.4 23:16:47 INFO - moznetwork == 0.27 23:16:47 INFO - mozprocess == 0.23 23:16:47 INFO - mozprofile == 0.28 23:16:47 INFO - mozrunner == 6.12 23:16:47 INFO - mozscreenshot == 0.1 23:16:47 INFO - mozsystemmonitor == 0.3 23:16:47 INFO - moztest == 0.7 23:16:47 INFO - mozversion == 1.4 23:16:47 INFO - psutil == 3.1.1 23:16:47 INFO - requests == 1.2.3 23:16:47 INFO - wsgiref == 0.1.2 23:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:47 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')]} 23:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 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')]} 23:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:47 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 23:16:47 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 23:16:47 INFO - Using env: {'DISPLAY': ':0', 23:16:47 INFO - 'HOME': '/home/cltbld', 23:16:47 INFO - 'LANG': 'en_US.UTF-8', 23:16:47 INFO - 'LANGUAGE': 'en_US:en', 23:16:47 INFO - 'LOGNAME': 'cltbld', 23:16:47 INFO - 'MAIL': '/var/mail/cltbld', 23:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:47 INFO - 'MOZ_NO_REMOTE': '1', 23:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:47 INFO - 'NO_EM_RESTART': '1', 23:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:47 INFO - 'PWD': '/builds/slave/test', 23:16:47 INFO - 'SHELL': '/bin/bash', 23:16:47 INFO - 'SHLVL': '1', 23:16:47 INFO - 'TERM': 'linux', 23:16:47 INFO - 'TMOUT': '86400', 23:16:47 INFO - 'USER': 'cltbld', 23:16:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:47 INFO - '_': '/tools/buildbot/bin/python'} 23:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 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)) 23:16:47 INFO - Cleaning up... 23:16:47 INFO - Return code: 0 23:16:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:16:47 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')]} 23:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 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')]} 23:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 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 0x7f09226eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf01ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', '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 23:16:47 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 23:16:47 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 23:16:47 INFO - Using env: {'DISPLAY': ':0', 23:16:47 INFO - 'HOME': '/home/cltbld', 23:16:47 INFO - 'LANG': 'en_US.UTF-8', 23:16:47 INFO - 'LANGUAGE': 'en_US:en', 23:16:47 INFO - 'LOGNAME': 'cltbld', 23:16:47 INFO - 'MAIL': '/var/mail/cltbld', 23:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:47 INFO - 'MOZ_NO_REMOTE': '1', 23:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:47 INFO - 'NO_EM_RESTART': '1', 23:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:47 INFO - 'PWD': '/builds/slave/test', 23:16:47 INFO - 'SHELL': '/bin/bash', 23:16:47 INFO - 'SHLVL': '1', 23:16:47 INFO - 'TERM': 'linux', 23:16:47 INFO - 'TMOUT': '86400', 23:16:47 INFO - 'USER': 'cltbld', 23:16:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:47 INFO - '_': '/tools/buildbot/bin/python'} 23:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:16:48 INFO - Cleaning up... 23:16:48 INFO - Return code: 0 23:16:48 INFO - Running post-action listener: _resource_record_post_action 23:16:48 INFO - Running post-action listener: _start_resource_monitoring 23:16:48 INFO - Starting resource monitoring. 23:16:48 INFO - [mozharness: 2016-10-04 06:16:48.070687Z] Finished create-virtualenv step (success) 23:16:48 INFO - [mozharness: 2016-10-04 06:16:48.071188Z] Running install step. 23:16:48 INFO - Running pre-action listener: _resource_record_pre_action 23:16:48 INFO - Running main action method: install 23:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:48 INFO - Reading from file tmpfile_stdout 23:16:48 INFO - Detecting whether we're running mozinstall >=1.0... 23:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:16:48 INFO - Reading from file tmpfile_stdout 23:16:48 INFO - Output received: 23:16:48 INFO - Usage: mozinstall [options] installer 23:16:48 INFO - Options: 23:16:48 INFO - -h, --help show this help message and exit 23:16:48 INFO - -d DEST, --destination=DEST 23:16:48 INFO - Directory to install application into. [default: 23:16:48 INFO - "/builds/slave/test"] 23:16:48 INFO - --app=APP Application being installed. [default: firefox] 23:16:48 INFO - mkdir: /builds/slave/test/build/application 23:16:48 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'] 23:16:48 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 23:17:05 INFO - Reading from file tmpfile_stdout 23:17:05 INFO - Output received: 23:17:05 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:05 INFO - Running post-action listener: _resource_record_post_action 23:17:05 INFO - [mozharness: 2016-10-04 06:17:05.368371Z] Finished install step (success) 23:17:05 INFO - [mozharness: 2016-10-04 06:17:05.368614Z] Running run-tests step. 23:17:05 INFO - Running pre-action listener: _resource_record_pre_action 23:17:05 INFO - Running main action method: run_tests 23:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:05 INFO - Python 2.7.3 23:17:05 INFO - Return code: 0 23:17:05 INFO - grabbing minidump binary from tooltool 23:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefef60>, '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 0xeffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf001d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:17:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:17:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:17:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:05 INFO - Return code: 0 23:17:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:17:05 INFO - Using env: {'DISPLAY': ':0', 23:17:05 INFO - 'HOME': '/home/cltbld', 23:17:05 INFO - 'LANG': 'en_US.UTF-8', 23:17:05 INFO - 'LANGUAGE': 'en_US:en', 23:17:05 INFO - 'LOGNAME': 'cltbld', 23:17:05 INFO - 'MAIL': '/var/mail/cltbld', 23:17:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:05 INFO - 'MOZ_NO_REMOTE': '1', 23:17:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:05 INFO - 'NO_EM_RESTART': '1', 23:17:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:05 INFO - 'PWD': '/builds/slave/test', 23:17:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:05 INFO - 'SHELL': '/bin/bash', 23:17:05 INFO - 'SHLVL': '1', 23:17:05 INFO - 'TERM': 'linux', 23:17:05 INFO - 'TMOUT': '86400', 23:17:05 INFO - 'USER': 'cltbld', 23:17:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003', 23:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:05 INFO - '_': '/tools/buildbot/bin/python'} 23:17:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:17:05 INFO - mozversion application_buildid: 20161003213045 23:17:05 INFO - mozversion application_changeset: 625a597ea7e3557d18487cf1616eb599f8ba34a2 23:17:05 INFO - mozversion application_display_name: Nightly 23:17:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:05 INFO - mozversion application_name: Firefox 23:17:05 INFO - mozversion application_remotingname: firefox 23:17:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:17:05 INFO - mozversion application_vendor: Mozilla 23:17:05 INFO - mozversion application_version: 52.0a1 23:17:05 INFO - mozversion platform_buildid: 20161003213045 23:17:05 INFO - mozversion platform_changeset: 625a597ea7e3557d18487cf1616eb599f8ba34a2 23:17:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:17:05 INFO - mozversion platform_version: 52.0a1 23:17:05 INFO - using testdate: 1475561825 23:17:05 INFO - actual date: 1475561825 23:17:05 INFO - starting webserver on 'localhost:38898' 23:17:05 INFO - SUITE-START | Running 2 tests 23:17:05 INFO - TEST-START | dromaeo_css 23:17:05 INFO - operating with platform_type : linux_ 23:17:05 INFO - Initialising browser for dromaeo_css test... 23:17:05 INFO - TEST-INFO | started process 4509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcmCzAi/profile http://localhost:38898/getInfo.html) 23:17:10 INFO - PROCESS | 4509 | __metrics Screen width/height:1600/1200 23:17:10 INFO - PROCESS | 4509 | colorDepth:24 23:17:10 INFO - PROCESS | 4509 | Browser inner width/height: 1024/697 23:17:10 INFO - PROCESS | 4509 | __metrics 23:17:10 INFO - PROCESS | 4509 | 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" 23:17:10 INFO - PROCESS | 4509 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:11 INFO - PROCESS | 4509 | console.error: PushService: 23:17:11 INFO - PROCESS | 4509 | stateChangeProcessEnqueue: Error transitioning state 23:17:11 INFO - PROCESS | 4509 | UnknownError 23:17:11 INFO - TEST-INFO | 4509: exit 0 23:17:11 INFO - Browser initialized. 23:17:11 INFO - Running cycle 1/1 for dromaeo_css test... 23:17:11 INFO - TEST-INFO | started process 4589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcmCzAi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:24 INFO - PROCESS | 4589 | RSS: Main: 173383680 23:17:24 INFO - PROCESS | 4589 | 23:18:15 INFO - PROCESS | 4589 | 1475561895557 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] 23:20:25 INFO - PROCESS | 4589 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38898/tests/dromaeo/cssquery-ext.html) 23:20:27 INFO - PROCESS | 4589 | RSS: Main: 295796736 23:20:27 INFO - PROCESS | 4589 | 23:23:29 INFO - PROCESS | 4589 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-ext.html (next: http://localhost:38898/tests/dromaeo/cssquery-jquery.html) 23:23:30 INFO - PROCESS | 4589 | RSS: Main: 274436096 23:23:30 INFO - PROCESS | 4589 | 23:26:32 INFO - PROCESS | 4589 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38898/tests/dromaeo/cssquery-mootools.html) 23:26:32 INFO - PROCESS | 4589 | RSS: Main: 216039424 23:26:32 INFO - PROCESS | 4589 | 23:29:34 INFO - PROCESS | 4589 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38898/tests/dromaeo/cssquery-prototype.html) 23:29:35 INFO - PROCESS | 4589 | RSS: Main: 239755264 23:29:35 INFO - PROCESS | 4589 | 23:32:38 INFO - PROCESS | 4589 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38898/tests/dromaeo/cssquery-yui.html) 23:32:38 INFO - PROCESS | 4589 | RSS: Main: 216809472 23:32:38 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | Cycle 1(1): loaded http://localhost:38898/tests/dromaeo/cssquery-yui.html (next: http://localhost:38898/tests/dromaeo/cssquery-dojo.html) 23:35:41 INFO - PROCESS | 4589 | RSS: Main: 309338112 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | __start_tp_report 23:35:41 INFO - PROCESS | 4589 | _x_x_mozilla_page_load 23:35:41 INFO - PROCESS | 4589 | _x_x_mozilla_page_load_details 23:35:41 INFO - PROCESS | 4589 | |i|pagename|runs| 23:35:41 INFO - PROCESS | 4589 | |0;dojo.html;2976.1666733314673;3001.384716133193;3019.260281231098;3030.1364111228304;3066.448039352917;5020.824271150511;5077.79688812448;5168.2764412982215;5247.763850626721;5263.921041184385;5115.9488405115935;5141.100307446191;5150.459201783806;5156;5216.713080780555;4777.761111944406;4803.9759801201035;4827.56551910328;4842.080004799094;4842.830500932468;4763.190257656207;4804.711717296956;4807.759612019402;4846.733429661367;4856.174450343432;4407.338899165119;4837.0567739290855;4840.9273860891935;4845.083899390503;4898.093852637274;4669.299605059235;4819.469858315582;4834.250691142878;4862.100511405401;4887.413510378778;4692.507286734878;4696.178168820477;4699.483056863743;4738.407699037621;4748.762561871893;5111.2333150027425;5119.206522988906;5124.436312005676;5199.66202196856;5261.842144735664;5526.668399896019;5561.833145005657;5562.582806289544;5572.275604171472;5605.243292155547;5425.240466334716;5471.151971444432;5472.288602481652;5525.0883604205255;5527.198556209368;5167.896642067175;5180.559652429548;5180.6891586504935;5186.870328241824;5189.896202075937;5629.887402251932;5636.351819540723;5639.182318563868;5646.096624540054;5710.8001219957105;5330.253764472977;5372.113601255749;5453.263809385761;5503.614746967673;5506.779728810883;5608.747606357723;5614.550835933115;5666.943330566724;5674.858128546737;5677.858053548612;5579.609427340129;5583.637063590853;5588.804391846266;5589.217509548666;5590;5413.404525502192;5460.672359658433;5561.63849349791;5613.522850557667;5666.829995100154;4272.081502476983;4273.55127711592;4293.914121717548;4305.56944305567;4343.67422443318;3810.1998580298446;3833.7316387852584;3848.422736589534;3881.4177873319227;3885.611438856092;5220.765065572058;5232.476752324737;5232.953409318152;5234;5241.292425522582;5477.370102438191;5531.585131115183;5546.084895992197;5565.1930470082425;5575.414581468968;5298.496642818926;5299.523042926078;5299.708516031578;5301.284326615934;5349.117395629755;4886.706797592155;4893.314935908976;4893.657443978958;4895.143349913822;4953.8018479261145;5571.331440227118;5650.886982260332;5715.342735585461;5741.971290143522;5787.623804452697;5607.607467477401;5608.046632072476;5609.046462101371;5656.321241451053;5675.233843431084;5720.628159169641;5759.049756790083;5783.16144159103;5787.305523337226;5793.073108302651;5395.190721391823;5432.619716619799;5457.154141107976;5515.751791169488;5517.889642207053;5572.832815015556;5610.074337734228;5618.6628802272;5670.489655930986;5674.148877668217;5461.481159289861;5461.863453413537;5464.808731694372;5467.234587157722;5470.097433923358;5306.071437498345;5353.598480113929;5453.754581043783;5467.917981230365;5472;5389.27244821944;5407.567394608343;5433.130699088285;5439.537639300704;5500.50495455411;5484.122540393518;5520.309961254843;5529.834104976857;5540.833774986757;5543.916841247304;5193.42872284056;5220.347456567929;5227.477252274742;5315.681059136464;5398.865028374322 23:35:41 INFO - PROCESS | 4589 | |1;ext.html;552.4888375193635;586.882623475305;592.4105515012564;593.3443544882904;603.9003564411872;31737.841310793443;42406.57593424069;43163.13673726524;43163.97852150343;43175.13649727003;45581;45995.54004459955;46000.30999535009;46083.769581152046;46311.76844115775;8042.115367309591;8984.775380615505;9152.862707059367;9156.084391560824;9159.679411220608;7968.561729104926;10527.84208236877;10822.621208257713;10823;11220.66338009861;11053.613123540677;11124.38815865127;11136.276142050741;11136.276142050781;11137.554497820078;8061.516309021477;8342.040665323444;10807.081398081173;10888.67333979982;10890.673279801618;10273.945210957763;10642.201834862417;10656.20078494116;11027.944860275727;11044.447777611167;42925.57074429278;43178;43303.35044974328;43370.132597348194;43386.78306608447;3514.437689969618;3516.2227771879366;3522.5633116075273;3607.873724419659;3794.1273507093247;31962.840185798923;32245;32372;32374.514382284284;32388.35223295521;4037.394390841397;4345.41336919515;4394.714343567658;4396.810665708652;4506.729596224237;341458;344627.9999999975;345416;352194;352227;58107.675692972654;58686.41313586895;58689;58704.41295587075;58718;60808.695956520816;60905.69547152236;61023;61107.083393749126;61113.38886611166;16284.185790710417;16509.504714858573;16518.6696266074;16535;16538.25577849;11182.66452006441;11638.6508404748;11673;12576.371181441074;12654.430550625244;16761.497155085366;17282.65434691324;17302.567435814206;17343.479695609152;17747.645047098984;6181.783637572753;6375.521835862329;6455.386738259858;6489.643069631121;6566.868662626721;960.9567569459251;1025.6974192613197;1029.9227557933184;1038.7331841358885;1133.8015847226702;29739.405211896075;31399.686003140134;31947.361052778815;32045.39205639004;32083.358332833213;1078.0836289154156;1091.6070214722693;1093.4259513755342;1093.4915264401932;1164.941752912351;15711.842881571267;16849.41027064047;16881;16896.155192240338;17130.14349282556;477680;478534;479769;481361;481692;57596;57783.4221657778;57810.710946445;57812.4218757807;57898.71050644804;1111.794318051147;1186.9287842729464;1306.431702209542;1338.2171429713726;1361.9717113579184;28330.85834570814;32647.18382040468;32770.344593107526;33321.50017749687;33864.49203261904;49883.25175122449;50658.49341506538;50674.49325506698;50741.746291268304;50783;381218;382645;384086;384553.1625572366;386264;39903;40289;41164.58835411727;41239.587604123575;41314;45883.082338352375;46948.295775562714;46962.29556556586;47104.29343559918;47174;39309.41035884407;40047;40476.79761601291;40560;41524.3771343424;39120;39293.21413571655;39745.80127099346;40707.389389159776;41796.3730544036;41051.58948410597;41230;41446;41687;41712.58287417087;32206.35587288194;35772;36109.06484560068;36518.26963460769;36747;27275.72724272732;27798.86100569565;27858;27998;28025 23:35:41 INFO - PROCESS | 4589 | |2;jquery.html;379.51422179610074;392.75256588349333;405.104718571956;407.460115347165;423.8050496771485;13156.736865262688;15255.923720381397;19032.61934761304;19415.514612134702;19862.60274794503;18629.254829806792;18675.159617817197;19064.61870762584;19203.711944320847;19261.422157335302;4624.260118381059;5403.13549832026;5629.859253518674;5641;5647.548196144298;5602.579806514507;5703.714814259291;5709.257796486451;5715.3141623005295;5715.3141623005295;5461.617686761928;5636.239107720467;5682.715864206773;5688.374278829326;5689.658620482764;5548.91676624851;5583.4137415571595;5589.04986152353;5594.832155035356;5626.465485778845;4866.58634016109;5020.824271150492;5048.444671086178;5054.393472783253;5077.873053173664;22101.447463813533;22203;22292.108315667352;22419.103235870545;22439.663405048937;2286.211257116292;2392.186656536786;2402.7717366850297;2665.160474450561;2831.9946419021157;13642.727145457135;14152.646183845383;14261.358238879275;14404.255848062205;14810.555683329518;1827.798942116366;1873.681474149398;1910.4937191644226;1968.6358023765506;1985.8312043476178;82334.80986542176;82534.17465825325;85236.14763852344;85814.57092714559;86112;10196.439195844152;10470.895291047143;10741.087007604285;11156;11796.174267801343;14555.981081324417;15096.24518774057;15155.469558565397;15180.089194648357;15219.162946037854;7609.581473019037;7862.33170180541;7969.880451793228;7984.201579842085;8174.836503269901;7087.645617719093;7175.569465832067;7185.101862267216;7345.963270183614;7417.629118544051;6499.220093588705;6598.109255250576;6624.8012559623285;6696.229933557704;6697;1803.4048763907879;1829.981700182981;1868.2905141795377;1877.4555378940227;1941.3108346536776;897.6768363389175;980.8332583460829;984.1487113646788;1040.3705758016442;1125.6904351303294;19082.713759293623;19937.401877943685;20011.699824502644;20065;20160.39518814438;1018.8981101889751;1021.1320377678913;1046.1369370269558;1094.819354806464;1098.423327752936;10247.333923294962;11077.845807822066;11395.316281023164;11423.771524569629;11440.828387574193;457464;457874;465507;470815;471609;79976.20023799688;80606;82775.5861220702;83585.58207208925;84739;1021.5709402051157;1026.9948650256702;1027.0397178637998;1065.0574241796066;1071.089573862211;16828.326866925185;17023.659526809643;17606.55983600369;17614.119294035503;17718.645627087644;36346.8182659085;37905.43141852819;39214.21571568496;39993;41217.38173927453;50636;50888.491115089855;52340.476595235086;53366;53822.730886345315;7830.647620857189;7897.736362182023;8302.916970830214;8401.32789376836;8467.36494762883;7798.766037018899;7899.802504937423;12366.381680916098;12770.808437873253;13018;11655.941720291345;11673.12451566119;11707.648770536898;11751.941240293743;11773.823392648947;10673.199510036933;10888.510017049093;10897.945510272399;11070.557177713123;11619.941900290445;11336.546538138382;11632.651020469399;11661.825072624088;11966.64100076999;11975.041996640073;8771.16673915977;8879;8886.822263554823;8926.68756593516;8968.820623587622;10712.785744284914;11933.701657458285;12009.039276858006;12013.399330033639;12069.456874440495 23:35:41 INFO - PROCESS | 4589 | |3;mootools.html;1307.8561358250597;1434.490755781697;1481.8221813382395;1600.3118658976634;1786.7409225662288;7318.743843965455;7844.843103137941;8113.716019939303;8356.080831108573;8362.121977192399;8278.710245141421;8354.456960297592;8372.665093396272;8375.288100511463;8379.581020948943;2256.9322920312416;2260.4122928038746;2261.5363850410668;2278.7835155660187;2280.133549251282;2143.110609097223;2159.8164156046755;2243.842930994823;2243.9439014024697;2268.7844654757855;2184.2464349799375;2220.5336879255374;2227.8106360959337;2238.21662418154;2238.597052530544;2154.5475450155486;2159.255057005331;2160.729908761413;2168.1544197762887;2173.945651358713;2206.6248737714627;2216.2797090945505;2218.234709025384;2222.9110835566557;2224.3882932193615;8338.24955753985;8391.580420978988;8396.538190399526;8401.075881653074;8405.95797021011;4928.26076088586;5062.746862656889;5076.416212135578;5140.1518749406305;5140.383154021504;3365.478350855621;3517.613062563116;3587.1032241939515;3593.8921832345072;3594.4967704521387;1086.397049637451;1132.0717012050122;1152.0553146419938;1164.342146687119;1171.7656468706293;11366.772664546745;11373.829392559119;11427.542898284059;11454.370009649467;11454.48454819535;4052.65552428041;4223.535411104776;4224.317558350408;4376.824927002885;4377.365282034088;8993.505357205286;9004;9005.864912026325;9005.864912026325;9011.864822027675;4926.236433352764;4938.259261110862;4943.9258411123865;4961.181405068123;4961.776720047606;4080.367543030835;4114.876553703393;4166.274571956382;4660.184467718203;4669.603083737852;3355.0102719697747;3642.2897534980425;3662.597114317423;3665.486831843544;3686.8156592170285;1094.5621751299384;1107.5846557540922;1117.4915413487006;1126.341090462089;1127.5320741892024;869.9826003479895;874.9825003499894;889.3418870036127;898.8876390451194;948.3172116076552;5386.48828361305;5424.077906755861;5430.375506816767;5508.9724551376985;5635.661860288314;419.91181851810853;446.5623688784944;455.06711241954525;457.62932025059143;459.3431393107821;3572.392693242103;3735.9626403735615;3736.626337366296;3774.6225377462033;3792.60177681345;9899.406035637885;10180.134688551556;10294.022067903537;10309.53607087683;10322.48387580618;10239.590416383262;10249.897501025043;10269.075783179549;10270.948645256725;10297.691069267934;7813.843723125506;7886.723964661324;7891.131975482693;7895.7236496722335;7899.091604465445;5420.349558053059;5452.536534394462;5453.618246722692;5544.362398324083;5625.437456254342;9162.587683554122;9245.121713437213;9262.907370926205;9381.34330596879;9563.856542151734;8732.432391894507;9209.677661281823;9373.1564159226;9391.389559678599;9814.852777208205;6487.513436492188;6633.369829866155;6732.495062870402;6807.489438292247;6931.1682598088555;7829.843403132019;8039.196080391914;8106.918930810616;8107.635156417858;8120.75637730869;7359.411247100326;7361.374283185989;7510.586917719578;7532;7566.848663026819;7288.854222915618;7293.562386256842;7303.525270857377;7416.66625001887;7427.628618568941;6565.671716414256;6575.30702016296;6632.403083722488;6662.800115996528;6664.833379165366;4706.764661766966;4716.811327546997;4775.880602984953;4925.876853078702;4935;4775.785089671042;4952.603791696583;5029.06962211992;5041.68916081814;5143.279940808215 23:35:41 INFO - PROCESS | 4589 | |4;prototype.html;324.8343344894105;331.4349034895503;332.6673326673327;340.50286581590876;341.0909925049743;5112.3098381718455;5240.161574148132;5246.632735708492;5277.6305658603915;5291.285676433685;5076.36545431821;5165.8450246492575;5201.453847346031;5210.140326846075;5248.346770767215;4133.607307305816;4134.214499245141;4147.5645057269;4154.979225103885;4186.74879507229;4033.334499807528;4149.04571948452;4166.958330416687;4191.413202151702;4228.788560571959;4053.1893621275863;4056.71602987791;4073.165001174752;4094;4107.732997355177;4063.553009168989;4084.836606535735;4085.59144085592;4100.1594673092095;4126;3618.113562177257;3626.8005259710703;3628.546431696038;3654.689351405134;3658.2317713280245;5000.499950005007;5115.488451154892;5135.666181698178;5150.072986862401;5158.974205128988;4663.720176789369;4674.205385084544;4739.459675605442;4766.547178018082;4767.189577771753;5437.510624043815;5474.09677403228;5474.507294343528;5505.256790333294;5540.390557038722;3763.7553559018575;3949.585293544194;3953.1895961328146;3958.4062390641634;3980.7014473914574;5616.550675945915;5634.464725851038;5640.871825634889;5659.462351076682;5695.572832037614;4054.0878302382316;4055.6349928506575;4089.427480152781;4091.5499295077516;4108.979455102705;3928.7642741435607;4084.9591504085174;4108.198901214294;4128.195001974646;4130.359794231899;4672;4677.976610116928;4698.929516057262;4707.764611769398;4713.670043097019;5494.994327070671;5495.450454954473;5512.924979629014;5565.998120338378;5584.413636568183;1327.3164320375015;1331.760283149023;1409.7180563887264;1414.8302203735411;1418.5886093032905;866.7616405488415;900.5452246615417;907.7775944893543;921.6820197032014;928.4846909964899;4601;4625.861224163281;4671.789769460383;4687.7656117194;4690.460597031385;4838.588719958772;4872.707637541759;4926.285688575136;4930.753462326869;4968.627352948543;4651.302304654261;4673.836415725434;4676.129548180755;4731.574158325767;4739.056986635463;2784.206501147163;2951.5425109108123;2952.099609619087;2959.201015725742;2959.9704002959693;5751.4118646609195;5754.856128596819;5779.248697669276;5792.275965504312;5805.8548536286935;5501.61166385586;5664.490195882308;5726.541876649858;5738.741756620962;5753.539716822728;5761.020626493422;5762.567807414461;5765.250517432791;5774.913376299275;5784.3926387729525;5574.968630803152;5601.691906945157;5616;5617.7191140442;5634.690092044977;5315.255864178941;5446.502211891761;5497.505224529811;5511.724413779215;5535.4187810280955;5797.681127537857;5803.274590676166;5812.854678632899;5830.2420685310635;5831.825045248649;3950.150717595731;4044.8786536403954;4068.145689405258;4071.470708807836;4072.5316588591504;5324.6006549508165;5539.362973257966;5540;5545.722713864371;5584.581156413366;5335;5386.43442438554;5421.918671219856;5447.319085114361;5462;5451.536619387396;5464.453554644663;5479.205515200353;5504.339479262514;5506.972465137648;5203.92194117081;5375.81184658535;5378.005069062236;5387.649802762808;5395.514403703685;5448.400675925565;5492.395836458067;5504.669719816664;5507.256520369699;5507.779688812403;5392.7573259202645;5393.191021346829;5401.756920938646;5403.216533602685;5418.701971391612 23:35:41 INFO - PROCESS | 4589 | |5;yui.html;716.0583832260573;735.8491509240606;759.0549765541901;778.9221077892215;821.6097353756965;13413.195208287498;14263.572092837205;14302.141871487693;14310.49913253035;14320.355583998718;15178.54464366068;15295.69408611827;15337;15341.232938353094;15358.078515289091;650.1353200243665;665.8235567574573;786.7875673568133;788.2590365056828;812.0134037144868;798.0104670208929;798.6525861250375;799.360511590728;801.463019776751;806.2743530822248;852.6845067325098;854.9572521373907;855.2644725536034;855.5978690015713;855.6620135046653;844.0588743550896;845.530730444603;846.5555583318745;847.0216899481109;847.0555330806168;498.34134890359974;507.0189183929109;611.339753066687;618.427954142421;621.0497938154631;15356.155411452366;15359;15386.230688465532;15392.769108463383;15401;13742.862571374259;14142.858571414257;14444.711105777931;14547;14666.633334166625;13032.152910060911;13111.409986550629;13139.14595551286;13336.799948000787;13546.187228766206;4380.89047773805;4397.274449715793;4426.402435671175;4430.601245887886;4661.277501987197;83058.58470707668;83173;84152;84183;84236;11327.886721132849;11344.546218151181;11393.772124557463;11796.410179490991;12005.159638825373;21699.674504882438;21727.67408488874;21744.34766956994;21850.45373865666;21889;8278.793030174294;8405.663773449116;8478.83042339162;8493.405461617751;8713.782155446164;4160.750354978711;4224.619784219373;4378.014946636981;4381.364702118175;4527.592516673515;3259.2666650004035;3329.783564068376;3336.899893003214;3337.9499307510405;3351.1957130288556;612.8039027511243;614.2168734862996;617.2099712368176;618.2951435363689;630.4389093706604;654.5287393076977;659.4638013873505;670.14851805567;675.8006388115517;682.3279070115932;8369.49783013021;8617.49407098863;8808.691695790616;9395.424836601236;9963.352382095141;575.025332062159;625.1497962770628;646.0890144895675;662.5494663628779;682.3960794696729;3928.27575266336;4267.274563324242;4303.074838909587;4309.010832043762;4378.4745830499905;113880;115028;123856;123972;126498;105390.47304763427;105749;106134.46932765287;107083.46458267815;108353;90661;91017.6168289701;92760.53619731993;93204;97746.5112674432;8045.557494337868;8242.134575869688;8379.318618042167;8384.790380240544;8715.869261960948;53205;53518.73240633772;53805.46194538005;54786.72606636941;55632.44367556435;47128;48457.27314090362;52205.7389713049;69809.65095174492;78390.6080469594;10874.565017399216;10877.347359158475;11130.276532025393;11229.66311010671;11293.854167708108;11836.918851113642;11958.880411195776;12173.20874143178;12300.261984280973;12350.505979760708;11934.761304773681;11958.940205299266;12045.156839021185;12060.819087713517;12132.818007730068;11674.591389301333;11706.414679266172;11996.280223186637;12245.448954796877;12427.44076516577;12853.614391568268;13696.3836627354;13707.520236791665;14129.646758831112;14145.363458644591;10279.94860025695;10714.357138571711;11031.062359699516;11132.610358637408;11214.719632009264;9232.538373081454;10217.284790064921;10778.730531736455;11297.548098075986;11544.82682759776 23:35:41 INFO - PROCESS | 4589 | __end_tp_report 23:35:41 INFO - PROCESS | 4589 | __start_cc_report 23:35:41 INFO - PROCESS | 4589 | _x_x_mozilla_cycle_collect,1083 23:35:41 INFO - PROCESS | 4589 | __end_cc_report 23:35:41 INFO - PROCESS | 4589 | __startTimestamp1475562941919__endTimestamp 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | ------- Summary: start ------- 23:35:41 INFO - PROCESS | 4589 | Number of tests: 6 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | [#0] dojo.html Cycles:165 Average:5180.14 Median:5372.11 stddev:573.57 (10.7%) stddev-sans-first:548.65 23:35:41 INFO - PROCESS | 4589 | Values: 2976.2 3001.4 3019.3 3030.1 3066.4 5020.8 5077.8 5168.3 5247.8 5263.9 5115.9 5141.1 5150.5 5156.0 5216.7 4777.8 4804.0 4827.6 4842.1 4842.8 4763.2 4804.7 4807.8 4846.7 4856.2 4407.3 4837.1 4840.9 4845.1 4898.1 4669.3 4819.5 4834.3 4862.1 4887.4 4692.5 4696.2 4699.5 4738.4 4748.8 5111.2 5119.2 5124.4 5199.7 5261.8 5526.7 5561.8 5562.6 5572.3 5605.2 5425.2 5471.2 5472.3 5525.1 5527.2 5167.9 5180.6 5180.7 5186.9 5189.9 5629.9 5636.4 5639.2 5646.1 5710.8 5330.3 5372.1 5453.3 5503.6 5506.8 5608.7 5614.6 5666.9 5674.9 5677.9 5579.6 5583.6 5588.8 5589.2 5590.0 5413.4 5460.7 5561.6 5613.5 5666.8 4272.1 4273.6 4293.9 4305.6 4343.7 3810.2 3833.7 3848.4 3881.4 3885.6 5220.8 5232.5 5233.0 5234.0 5241.3 5477.4 5531.6 5546.1 5565.2 5575.4 5298.5 5299.5 5299.7 5301.3 5349.1 4886.7 4893.3 4893.7 4895.1 4953.8 5571.3 5650.9 5715.3 5742.0 5787.6 5607.6 5608.0 5609.0 5656.3 5675.2 5720.6 5759.0 5783.2 5787.3 5793.1 5395.2 5432.6 5457.2 5515.8 5517.9 5572.8 5610.1 5618.7 5670.5 5674.1 5461.5 5461.9 5464.8 5467.2 5470.1 5306.1 5353.6 5453.8 5467.9 5472.0 5389.3 5407.6 5433.1 5439.5 5500.5 5484.1 5520.3 5529.8 5540.8 5543.9 5193.4 5220.3 5227.5 5315.7 5398.9 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | [#1] ext.html Cycles:180 Average:57468.07 Median:385408.58 stddev:107455.32 (27.9%) stddev-sans-first:107671.79 23:35:41 INFO - PROCESS | 4589 | Values: 552.5 586.9 592.4 593.3 603.9 31737.8 42406.6 43163.1 43164.0 43175.1 45581.0 45995.5 46000.3 46083.8 46311.8 8042.1 8984.8 9152.9 9156.1 9159.7 7968.6 10527.8 10822.6 10823.0 11220.7 11053.6 11124.4 11136.3 11136.3 11137.6 8061.5 8342.0 10807.1 10888.7 10890.7 10273.9 10642.2 10656.2 11027.9 11044.4 42925.6 43178.0 43303.4 43370.1 43386.8 3514.4 3516.2 3522.6 3607.9 3794.1 31962.8 32245.0 32372.0 32374.5 32388.4 4037.4 4345.4 4394.7 4396.8 4506.7 341458.0 344628.0 345416.0 352194.0 352227.0 58107.7 58686.4 58689.0 58704.4 58718.0 60808.7 60905.7 61023.0 61107.1 61113.4 16284.2 16509.5 16518.7 16535.0 16538.3 11182.7 11638.7 11673.0 12576.4 12654.4 16761.5 17282.7 17302.6 17343.5 17747.6 6181.8 6375.5 6455.4 6489.6 6566.9 961.0 1025.7 1029.9 1038.7 1133.8 29739.4 31399.7 31947.4 32045.4 32083.4 1078.1 1091.6 1093.4 1093.5 1164.9 15711.8 16849.4 16881.0 16896.2 17130.1 477680.0 478534.0 479769.0 481361.0 481692.0 57596.0 57783.4 57810.7 57812.4 57898.7 1111.8 1186.9 1306.4 1338.2 1362.0 28330.9 32647.2 32770.3 33321.5 33864.5 49883.3 50658.5 50674.5 50741.7 50783.0 381218.0 382645.0 384086.0 384553.2 386264.0 39903.0 40289.0 41164.6 41239.6 41314.0 45883.1 46948.3 46962.3 47104.3 47174.0 39309.4 40047.0 40476.8 40560.0 41524.4 39120.0 39293.2 39745.8 40707.4 41796.4 41051.6 41230.0 41446.0 41687.0 41712.6 32206.4 35772.0 36109.1 36518.3 36747.0 27275.7 27798.9 27858.0 27998.0 28025.0 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | [#2] jquery.html Cycles:180 Average:27849.40 Median:2339.20 stddev:76559.21 (3272.9%) stddev-sans-first:76746.20 23:35:41 INFO - PROCESS | 4589 | Values: 379.5 392.8 405.1 407.5 423.8 13156.7 15255.9 19032.6 19415.5 19862.6 18629.3 18675.2 19064.6 19203.7 19261.4 4624.3 5403.1 5629.9 5641.0 5647.5 5602.6 5703.7 5709.3 5715.3 5715.3 5461.6 5636.2 5682.7 5688.4 5689.7 5548.9 5583.4 5589.0 5594.8 5626.5 4866.6 5020.8 5048.4 5054.4 5077.9 22101.4 22203.0 22292.1 22419.1 22439.7 2286.2 2392.2 2402.8 2665.2 2832.0 13642.7 14152.6 14261.4 14404.3 14810.6 1827.8 1873.7 1910.5 1968.6 1985.8 82334.8 82534.2 85236.1 85814.6 86112.0 10196.4 10470.9 10741.1 11156.0 11796.2 14556.0 15096.2 15155.5 15180.1 15219.2 7609.6 7862.3 7969.9 7984.2 8174.8 7087.6 7175.6 7185.1 7346.0 7417.6 6499.2 6598.1 6624.8 6696.2 6697.0 1803.4 1830.0 1868.3 1877.5 1941.3 897.7 980.8 984.1 1040.4 1125.7 19082.7 19937.4 20011.7 20065.0 20160.4 1018.9 1021.1 1046.1 1094.8 1098.4 10247.3 11077.8 11395.3 11423.8 11440.8 457464.0 457874.0 465507.0 470815.0 471609.0 79976.2 80606.0 82775.6 83585.6 84739.0 1021.6 1027.0 1027.0 1065.1 1071.1 16828.3 17023.7 17606.6 17614.1 17718.6 36346.8 37905.4 39214.2 39993.0 41217.4 50636.0 50888.5 52340.5 53366.0 53822.7 7830.6 7897.7 8302.9 8401.3 8467.4 7798.8 7899.8 12366.4 12770.8 13018.0 11655.9 11673.1 11707.6 11751.9 11773.8 10673.2 10888.5 10897.9 11070.6 11619.9 11336.5 11632.7 11661.8 11966.6 11975.0 8771.2 8879.0 8886.8 8926.7 8968.8 10712.8 11933.7 12009.0 12013.4 12069.5 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | [#3] mootools.html Cycles:180 Average:5410.10 Median:4931.63 stddev:3062.35 (62.1%) stddev-sans-first:3055.42 23:35:41 INFO - PROCESS | 4589 | Values: 1307.9 1434.5 1481.8 1600.3 1786.7 7318.7 7844.8 8113.7 8356.1 8362.1 8278.7 8354.5 8372.7 8375.3 8379.6 2256.9 2260.4 2261.5 2278.8 2280.1 2143.1 2159.8 2243.8 2243.9 2268.8 2184.2 2220.5 2227.8 2238.2 2238.6 2154.5 2159.3 2160.7 2168.2 2173.9 2206.6 2216.3 2218.2 2222.9 2224.4 8338.2 8391.6 8396.5 8401.1 8406.0 4928.3 5062.7 5076.4 5140.2 5140.4 3365.5 3517.6 3587.1 3593.9 3594.5 1086.4 1132.1 1152.1 1164.3 1171.8 11366.8 11373.8 11427.5 11454.4 11454.5 4052.7 4223.5 4224.3 4376.8 4377.4 8993.5 9004.0 9005.9 9005.9 9011.9 4926.2 4938.3 4943.9 4961.2 4961.8 4080.4 4114.9 4166.3 4660.2 4669.6 3355.0 3642.3 3662.6 3665.5 3686.8 1094.6 1107.6 1117.5 1126.3 1127.5 870.0 875.0 889.3 898.9 948.3 5386.5 5424.1 5430.4 5509.0 5635.7 419.9 446.6 455.1 457.6 459.3 3572.4 3736.0 3736.6 3774.6 3792.6 9899.4 10180.1 10294.0 10309.5 10322.5 10239.6 10249.9 10269.1 10270.9 10297.7 7813.8 7886.7 7891.1 7895.7 7899.1 5420.3 5452.5 5453.6 5544.4 5625.4 9162.6 9245.1 9262.9 9381.3 9563.9 8732.4 9209.7 9373.2 9391.4 9814.9 6487.5 6633.4 6732.5 6807.5 6931.2 7829.8 8039.2 8106.9 8107.6 8120.8 7359.4 7361.4 7510.6 7532.0 7566.8 7288.9 7293.6 7303.5 7416.7 7427.6 6565.7 6575.3 6632.4 6662.8 6664.8 4706.8 4716.8 4775.9 4925.9 4935.0 4775.8 4952.6 5029.1 5041.7 5143.3 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | [#4] prototype.html Cycles:180 Average:4566.31 Median:5154.52 stddev:1332.22 (25.8%) stddev-sans-first:1297.37 23:35:41 INFO - PROCESS | 4589 | Values: 324.8 331.4 332.7 340.5 341.1 5112.3 5240.2 5246.6 5277.6 5291.3 5076.4 5165.8 5201.5 5210.1 5248.3 4133.6 4134.2 4147.6 4155.0 4186.7 4033.3 4149.0 4167.0 4191.4 4228.8 4053.2 4056.7 4073.2 4094.0 4107.7 4063.6 4084.8 4085.6 4100.2 4126.0 3618.1 3626.8 3628.5 3654.7 3658.2 5000.5 5115.5 5135.7 5150.1 5159.0 4663.7 4674.2 4739.5 4766.5 4767.2 5437.5 5474.1 5474.5 5505.3 5540.4 3763.8 3949.6 3953.2 3958.4 3980.7 5616.6 5634.5 5640.9 5659.5 5695.6 4054.1 4055.6 4089.4 4091.5 4109.0 3928.8 4085.0 4108.2 4128.2 4130.4 4672.0 4678.0 4698.9 4707.8 4713.7 5495.0 5495.5 5512.9 5566.0 5584.4 1327.3 1331.8 1409.7 1414.8 1418.6 866.8 900.5 907.8 921.7 928.5 4601.0 4625.9 4671.8 4687.8 4690.5 4838.6 4872.7 4926.3 4930.8 4968.6 4651.3 4673.8 4676.1 4731.6 4739.1 2784.2 2951.5 2952.1 2959.2 2960.0 5751.4 5754.9 5779.2 5792.3 5805.9 5501.6 5664.5 5726.5 5738.7 5753.5 5761.0 5762.6 5765.3 5774.9 5784.4 5575.0 5601.7 5616.0 5617.7 5634.7 5315.3 5446.5 5497.5 5511.7 5535.4 5797.7 5803.3 5812.9 5830.2 5831.8 3950.2 4044.9 4068.1 4071.5 4072.5 5324.6 5539.4 5540.0 5545.7 5584.6 5335.0 5386.4 5421.9 5447.3 5462.0 5451.5 5464.5 5479.2 5504.3 5507.0 5203.9 5375.8 5378.0 5387.6 5395.5 5448.4 5492.4 5504.7 5507.3 5507.8 5392.8 5393.2 5401.8 5403.2 5418.7 23:35:41 INFO - PROCESS | 4589 | 23:35:41 INFO - PROCESS | 4589 | [#5] yui.html Cycles:180 Average:20951.85 Median:4378.24 stddev:31423.70 (717.7%) stddev-sans-first:31475.12 23:35:41 INFO - PROCESS | 4589 | Values: 716.1 735.8 759.1 778.9 821.6 13413.2 14263.6 14302.1 14310.5 14320.4 15178.5 15295.7 15337.0 15341.2 15358.1 650.1 665.8 786.8 788.3 812.0 798.0 798.7 799.4 801.5 806.3 852.7 855.0 855.3 855.6 855.7 844.1 845.5 846.6 847.0 847.1 498.3 507.0 611.3 618.4 621.0 15356.2 15359.0 15386.2 15392.8 15401.0 13742.9 14142.9 14444.7 14547.0 14666.6 13032.2 13111.4 13139.1 13336.8 13546.2 4380.9 4397.3 4426.4 4430.6 4661.3 83058.6 83173.0 84152.0 84183.0 84236.0 11327.9 11344.5 11393.8 11796.4 12005.2 21699.7 21727.7 21744.3 21850.5 21889.0 8278.8 8405.7 8478.8 8493.4 8713.8 4160.8 4224.6 4378.0 4381.4 4527.6 3259.3 3329.8 3336.9 3337.9 3351.2 612.8 614.2 617.2 618.3 630.4 654.5 659.5 670.1 675.8 682.3 8369.5 8617.5 8808.7 9395.4 9963.4 575.0 625.1 646.1 662.5 682.4 3928.3 4267.3 4303.1 4309.0 4378.5 113880.0 115028.0 123856.0 123972.0 126498.0 105390.5 105749.0 106134.5 107083.5 108353.0 90661.0 91017.6 92760.5 93204.0 97746.5 8045.6 8242.1 8379.3 8384.8 8715.9 53205.0 53518.7 53805.5 54786.7 55632.4 47128.0 48457.3 52205.7 69809.7 78390.6 10874.6 10877.3 11130.3 11229.7 11293.9 11836.9 11958.9 12173.2 12300.3 12350.5 11934.8 11958.9 12045.2 12060.8 12132.8 11674.6 11706.4 11996.3 12245.4 12427.4 12853.6 13696.4 13707.5 14129.6 14145.4 10279.9 10714.4 11031.1 11132.6 11214.7 9232.5 10217.3 10778.7 11297.5 11544.8 23:35:41 INFO - PROCESS | 4589 | -------- Summary: end -------- 23:35:41 INFO - PROCESS | 4589 | 23:35:42 INFO - TEST-INFO | 4589: exit 0 23:35:42 INFO - TEST-OK | dromaeo_css | took 1117202ms 23:35:42 INFO - TEST-START | kraken 23:35:42 INFO - operating with platform_type : linux_ 23:35:42 INFO - Initialising browser for kraken test... 23:35:42 INFO - TEST-INFO | started process 4895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1uImVa/profile http://localhost:38898/getInfo.html) 23:35:47 INFO - PROCESS | 4895 | __metrics Screen width/height:1600/1200 23:35:47 INFO - PROCESS | 4895 | colorDepth:24 23:35:47 INFO - PROCESS | 4895 | Browser inner width/height: 1024/697 23:35:47 INFO - PROCESS | 4895 | __metrics 23:35:47 INFO - PROCESS | 4895 | 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" 23:35:47 INFO - PROCESS | 4895 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:35:48 INFO - PROCESS | 4895 | console.error: PushService: 23:35:48 INFO - PROCESS | 4895 | stateChangeProcessEnqueue: Error transitioning state 23:35:48 INFO - PROCESS | 4895 | UnknownError 23:35:49 INFO - TEST-INFO | 4895: exit 0 23:35:49 INFO - Browser initialized. 23:35:49 INFO - Running cycle 1/1 for kraken test... 23:35:49 INFO - TEST-INFO | started process 4977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1uImVa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:01 INFO - PROCESS | 4977 | RSS: Main: 172896256 23:36:01 INFO - PROCESS | 4977 | 23:36:03 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:04 INFO - PROCESS | 4977 | RSS: Main: 231907328 23:36:04 INFO - PROCESS | 4977 | 23:36:07 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-dft) 23:36:08 INFO - PROCESS | 4977 | RSS: Main: 217300992 23:36:08 INFO - PROCESS | 4977 | 23:36:11 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-fft) 23:36:11 INFO - PROCESS | 4977 | RSS: Main: 299134976 23:36:11 INFO - PROCESS | 4977 | 23:36:13 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38898/tests/kraken/driver.html?testName=audio-oscillator) 23:36:14 INFO - PROCESS | 4977 | RSS: Main: 208068608 23:36:14 INFO - PROCESS | 4977 | 23:36:16 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:17 INFO - PROCESS | 4977 | RSS: Main: 213032960 23:36:17 INFO - PROCESS | 4977 | 23:36:20 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38898/tests/kraken/driver.html?testName=imaging-darkroom) 23:36:20 INFO - PROCESS | 4977 | RSS: Main: 249233408 23:36:20 INFO - PROCESS | 4977 | 23:36:24 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38898/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:24 INFO - PROCESS | 4977 | RSS: Main: 248463360 23:36:24 INFO - PROCESS | 4977 | 23:36:27 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38898/tests/kraken/driver.html?testName=json-parse-financial) 23:36:28 INFO - PROCESS | 4977 | RSS: Main: 247640064 23:36:28 INFO - PROCESS | 4977 | 23:36:29 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:36:30 INFO - PROCESS | 4977 | RSS: Main: 210108416 23:36:30 INFO - PROCESS | 4977 | 23:36:32 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:36:32 INFO - PROCESS | 4977 | RSS: Main: 217202688 23:36:32 INFO - PROCESS | 4977 | 23:36:34 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:36:35 INFO - PROCESS | 4977 | RSS: Main: 226344960 23:36:35 INFO - PROCESS | 4977 | 23:36:38 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:36:38 INFO - PROCESS | 4977 | RSS: Main: 235290624 23:36:38 INFO - PROCESS | 4977 | 23:36:41 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:42 INFO - PROCESS | 4977 | RSS: Main: 232816640 23:36:42 INFO - PROCESS | 4977 | 23:36:43 INFO - PROCESS | 4977 | Cycle 1(1): loaded http://localhost:38898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38898/tests/kraken/driver.html?testName=ai-astar) 23:36:44 INFO - PROCESS | 4977 | RSS: Main: 283676672 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | __start_tp_report 23:36:44 INFO - PROCESS | 4977 | _x_x_mozilla_page_load 23:36:44 INFO - PROCESS | 4977 | _x_x_mozilla_page_load_details 23:36:44 INFO - PROCESS | 4977 | |i|pagename|runs| 23:36:44 INFO - PROCESS | 4977 | |0;ai-astar;111;113;116;114;116;116;115;117;114;115 23:36:44 INFO - PROCESS | 4977 | |1;audio-beat-detection;154;122;124;163;124;125;128;125;155;124 23:36:44 INFO - PROCESS | 4977 | |2;audio-dft;161;161;161;162;160;161;161;163;162;164 23:36:44 INFO - PROCESS | 4977 | |3;audio-fft;75;76;76;105;76;76;77;78;114;77 23:36:44 INFO - PROCESS | 4977 | |4;audio-oscillator;82;82;123;83;82;83;109;81;82;106 23:36:44 INFO - PROCESS | 4977 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;116;118;117 23:36:44 INFO - PROCESS | 4977 | |6;imaging-darkroom;147;147;146;146;147;146;146;146;147;147 23:36:44 INFO - PROCESS | 4977 | |7;imaging-desaturate;95;96;96;95;96;95;96;97;96;96 23:36:44 INFO - PROCESS | 4977 | |8;json-parse-financial;52;55;53;53;52;52;52;53;54;53 23:36:44 INFO - PROCESS | 4977 | |9;json-stringify-tinderbox;62;61;62;62;62;62;61;62;62;62 23:36:44 INFO - PROCESS | 4977 | |10;stanford-crypto-aes;80;90;83;80;81;84;80;86;83;80 23:36:44 INFO - PROCESS | 4977 | |11;stanford-crypto-ccm;129;129;128;131;134;131;134;138;166;142 23:36:44 INFO - PROCESS | 4977 | |12;stanford-crypto-pbkdf2;169;165;166;165;166;165;165;166;169;166 23:36:44 INFO - PROCESS | 4977 | |13;stanford-crypto-sha256-iterative;65;66;67;70;65;67;66;65;67;64 23:36:44 INFO - PROCESS | 4977 | __end_tp_report 23:36:44 INFO - PROCESS | 4977 | __start_cc_report 23:36:44 INFO - PROCESS | 4977 | _x_x_mozilla_cycle_collect,1649 23:36:44 INFO - PROCESS | 4977 | __end_cc_report 23:36:44 INFO - PROCESS | 4977 | __startTimestamp1475563004149__endTimestamp 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | ------- Summary: start ------- 23:36:44 INFO - PROCESS | 4977 | Number of tests: 14 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.50 stddev:1.77 (1.5%) stddev-sans-first:1.27 23:36:44 INFO - PROCESS | 4977 | Values: 111.0 113.0 116.0 114.0 116.0 116.0 115.0 117.0 114.0 115.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:126.50 stddev:16.06 (12.7%) stddev-sans-first:15.39 23:36:44 INFO - PROCESS | 4977 | Values: 154.0 122.0 124.0 163.0 124.0 125.0 128.0 125.0 155.0 124.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 23:36:44 INFO - PROCESS | 4977 | Values: 161.0 161.0 161.0 162.0 160.0 161.0 161.0 163.0 162.0 164.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.15 (18.6%) stddev-sans-first:14.71 23:36:44 INFO - PROCESS | 4977 | Values: 75.0 76.0 76.0 105.0 76.0 76.0 77.0 78.0 114.0 77.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:82.00 stddev:15.36 (18.7%) stddev-sans-first:15.92 23:36:44 INFO - PROCESS | 4977 | Values: 82.0 82.0 123.0 83.0 82.0 83.0 109.0 81.0 82.0 106.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 23:36:44 INFO - PROCESS | 4977 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 118.0 117.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 23:36:44 INFO - PROCESS | 4977 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 23:36:44 INFO - PROCESS | 4977 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 23:36:44 INFO - PROCESS | 4977 | Values: 52.0 55.0 53.0 53.0 52.0 52.0 52.0 53.0 54.0 53.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 23:36:44 INFO - PROCESS | 4977 | Values: 62.0 61.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:3.30 (4.0%) stddev-sans-first:3.35 23:36:44 INFO - PROCESS | 4977 | Values: 80.0 90.0 83.0 80.0 81.0 84.0 80.0 86.0 83.0 80.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:134.00 stddev:11.35 (8.5%) stddev-sans-first:11.74 23:36:44 INFO - PROCESS | 4977 | Values: 129.0 129.0 128.0 131.0 134.0 131.0 134.0 138.0 166.0 142.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.00 stddev:1.55 (0.9%) stddev-sans-first:1.27 23:36:44 INFO - PROCESS | 4977 | Values: 169.0 165.0 166.0 165.0 166.0 165.0 165.0 166.0 169.0 166.0 23:36:44 INFO - PROCESS | 4977 | 23:36:44 INFO - PROCESS | 4977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.69 (2.5%) stddev-sans-first:1.73 23:36:44 INFO - PROCESS | 4977 | Values: 65.0 66.0 67.0 70.0 65.0 67.0 66.0 65.0 67.0 64.0 23:36:44 INFO - PROCESS | 4977 | -------- Summary: end -------- 23:36:44 INFO - PROCESS | 4977 | 23:36:45 INFO - TEST-INFO | 4977: exit 0 23:36:45 INFO - TEST-OK | kraken | took 62496ms 23:36:45 INFO - SUITE-END | took 1179s 23:36:45 INFO - Completed test suite (00:19:40) 23:36:45 INFO - javascript benchmark 23:36:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2976.1666733314673, 3001.384716133193, 3019.260281231098, 3030.1364111228304, 3066.448039352917, 5020.824271150511, 5077.79688812448, 5168.2764412982215, 5247.763850626721, 5263.921041184385, 5115.9488405115935, 5141.100307446191, 5150.459201783806, 5156.0, 5216.713080780555, 4777.761111944406, 4803.9759801201035, 4827.56551910328, 4842.080004799094, 4842.830500932468, 4763.190257656207, 4804.711717296956, 4807.759612019402, 4846.733429661367, 4856.174450343432, 4407.338899165119, 4837.0567739290855, 4840.9273860891935, 4845.083899390503, 4898.093852637274, 4669.299605059235, 4819.469858315582, 4834.250691142878, 4862.100511405401, 4887.413510378778, 4692.507286734878, 4696.178168820477, 4699.483056863743, 4738.407699037621, 4748.762561871893, 5111.2333150027425, 5119.206522988906, 5124.436312005676, 5199.66202196856, 5261.842144735664, 5526.668399896019, 5561.833145005657, 5562.582806289544, 5572.275604171472, 5605.243292155547, 5425.240466334716, 5471.151971444432, 5472.288602481652, 5525.0883604205255, 5527.198556209368, 5167.896642067175, 5180.559652429548, 5180.6891586504935, 5186.870328241824, 5189.896202075937, 5629.887402251932, 5636.351819540723, 5639.182318563868, 5646.096624540054, 5710.8001219957105, 5330.253764472977, 5372.113601255749, 5453.263809385761, 5503.614746967673, 5506.779728810883, 5608.747606357723, 5614.550835933115, 5666.943330566724, 5674.858128546737, 5677.858053548612, 5579.609427340129, 5583.637063590853, 5588.804391846266, 5589.217509548666, 5590.0, 5413.404525502192, 5460.672359658433, 5561.63849349791, 5613.522850557667, 5666.829995100154, 4272.081502476983, 4273.55127711592, 4293.914121717548, 4305.56944305567, 4343.67422443318, 3810.1998580298446, 3833.7316387852584, 3848.422736589534, 3881.4177873319227, 3885.611438856092, 5220.765065572058, 5232.476752324737, 5232.953409318152, 5234.0, 5241.292425522582, 5477.370102438191, 5531.585131115183, 5546.084895992197, 5565.1930470082425, 5575.414581468968, 5298.496642818926, 5299.523042926078, 5299.708516031578, 5301.284326615934, 5349.117395629755, 4886.706797592155, 4893.314935908976, 4893.657443978958, 4895.143349913822, 4953.8018479261145, 5571.331440227118, 5650.886982260332, 5715.342735585461, 5741.971290143522, 5787.623804452697, 5607.607467477401, 5608.046632072476, 5609.046462101371, 5656.321241451053, 5675.233843431084, 5720.628159169641, 5759.049756790083, 5783.16144159103, 5787.305523337226, 5793.073108302651, 5395.190721391823, 5432.619716619799, 5457.154141107976, 5515.751791169488, 5517.889642207053, 5572.832815015556, 5610.074337734228, 5618.6628802272, 5670.489655930986, 5674.148877668217, 5461.481159289861, 5461.863453413537, 5464.808731694372, 5467.234587157722, 5470.097433923358, 5306.071437498345, 5353.598480113929, 5453.754581043783, 5467.917981230365, 5472.0, 5389.27244821944, 5407.567394608343, 5433.130699088285, 5439.537639300704, 5500.50495455411, 5484.122540393518, 5520.309961254843, 5529.834104976857, 5540.833774986757, 5543.916841247304, 5193.42872284056, 5220.347456567929, 5227.477252274742, 5315.681059136464, 5398.865028374322], "value": 5142.2790274072395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4888375193635, 586.882623475305, 592.4105515012564, 593.3443544882904, 603.9003564411872, 31737.841310793443, 42406.57593424069, 43163.13673726524, 43163.97852150343, 43175.13649727003, 45581.0, 45995.54004459955, 46000.30999535009, 46083.769581152046, 46311.76844115775, 8042.115367309591, 8984.775380615505, 9152.862707059367, 9156.084391560824, 9159.679411220608, 7968.561729104926, 10527.84208236877, 10822.621208257713, 10823.0, 11220.66338009861, 11053.613123540677, 11124.38815865127, 11136.276142050741, 11136.276142050781, 11137.554497820078, 8061.516309021477, 8342.040665323444, 10807.081398081173, 10888.67333979982, 10890.673279801618, 10273.945210957763, 10642.201834862417, 10656.20078494116, 11027.944860275727, 11044.447777611167, 42925.57074429278, 43178.0, 43303.35044974328, 43370.132597348194, 43386.78306608447, 3514.437689969618, 3516.2227771879366, 3522.5633116075273, 3607.873724419659, 3794.1273507093247, 31962.840185798923, 32245.0, 32372.0, 32374.514382284284, 32388.35223295521, 4037.394390841397, 4345.41336919515, 4394.714343567658, 4396.810665708652, 4506.729596224237, 341458.0, 344627.9999999975, 345416.0, 352194.0, 352227.0, 58107.675692972654, 58686.41313586895, 58689.0, 58704.41295587075, 58718.0, 60808.695956520816, 60905.69547152236, 61023.0, 61107.083393749126, 61113.38886611166, 16284.185790710417, 16509.504714858573, 16518.6696266074, 16535.0, 16538.25577849, 11182.66452006441, 11638.6508404748, 11673.0, 12576.371181441074, 12654.430550625244, 16761.497155085366, 17282.65434691324, 17302.567435814206, 17343.479695609152, 17747.645047098984, 6181.783637572753, 6375.521835862329, 6455.386738259858, 6489.643069631121, 6566.868662626721, 960.9567569459251, 1025.6974192613197, 1029.9227557933184, 1038.7331841358885, 1133.8015847226702, 29739.405211896075, 31399.686003140134, 31947.361052778815, 32045.39205639004, 32083.358332833213, 1078.0836289154156, 1091.6070214722693, 1093.4259513755342, 1093.4915264401932, 1164.941752912351, 15711.842881571267, 16849.41027064047, 16881.0, 16896.155192240338, 17130.14349282556, 477680.0, 478534.0, 479769.0, 481361.0, 481692.0, 57596.0, 57783.4221657778, 57810.710946445, 57812.4218757807, 57898.71050644804, 1111.794318051147, 1186.9287842729464, 1306.431702209542, 1338.2171429713726, 1361.9717113579184, 28330.85834570814, 32647.18382040468, 32770.344593107526, 33321.50017749687, 33864.49203261904, 49883.25175122449, 50658.49341506538, 50674.49325506698, 50741.746291268304, 50783.0, 381218.0, 382645.0, 384086.0, 384553.1625572366, 386264.0, 39903.0, 40289.0, 41164.58835411727, 41239.587604123575, 41314.0, 45883.082338352375, 46948.295775562714, 46962.29556556586, 47104.29343559918, 47174.0, 39309.41035884407, 40047.0, 40476.79761601291, 40560.0, 41524.3771343424, 39120.0, 39293.21413571655, 39745.80127099346, 40707.389389159776, 41796.3730544036, 41051.58948410597, 41230.0, 41446.0, 41687.0, 41712.58287417087, 32206.35587288194, 35772.0, 36109.06484560068, 36518.26963460769, 36747.0, 27275.72724272732, 27798.86100569565, 27858.0, 27998.0, 28025.0], "value": 20287.671992015476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.51422179610074, 392.75256588349333, 405.104718571956, 407.460115347165, 423.8050496771485, 13156.736865262688, 15255.923720381397, 19032.61934761304, 19415.514612134702, 19862.60274794503, 18629.254829806792, 18675.159617817197, 19064.61870762584, 19203.711944320847, 19261.422157335302, 4624.260118381059, 5403.13549832026, 5629.859253518674, 5641.0, 5647.548196144298, 5602.579806514507, 5703.714814259291, 5709.257796486451, 5715.3141623005295, 5715.3141623005295, 5461.617686761928, 5636.239107720467, 5682.715864206773, 5688.374278829326, 5689.658620482764, 5548.91676624851, 5583.4137415571595, 5589.04986152353, 5594.832155035356, 5626.465485778845, 4866.58634016109, 5020.824271150492, 5048.444671086178, 5054.393472783253, 5077.873053173664, 22101.447463813533, 22203.0, 22292.108315667352, 22419.103235870545, 22439.663405048937, 2286.211257116292, 2392.186656536786, 2402.7717366850297, 2665.160474450561, 2831.9946419021157, 13642.727145457135, 14152.646183845383, 14261.358238879275, 14404.255848062205, 14810.555683329518, 1827.798942116366, 1873.681474149398, 1910.4937191644226, 1968.6358023765506, 1985.8312043476178, 82334.80986542176, 82534.17465825325, 85236.14763852344, 85814.57092714559, 86112.0, 10196.439195844152, 10470.895291047143, 10741.087007604285, 11156.0, 11796.174267801343, 14555.981081324417, 15096.24518774057, 15155.469558565397, 15180.089194648357, 15219.162946037854, 7609.581473019037, 7862.33170180541, 7969.880451793228, 7984.201579842085, 8174.836503269901, 7087.645617719093, 7175.569465832067, 7185.101862267216, 7345.963270183614, 7417.629118544051, 6499.220093588705, 6598.109255250576, 6624.8012559623285, 6696.229933557704, 6697.0, 1803.4048763907879, 1829.981700182981, 1868.2905141795377, 1877.4555378940227, 1941.3108346536776, 897.6768363389175, 980.8332583460829, 984.1487113646788, 1040.3705758016442, 1125.6904351303294, 19082.713759293623, 19937.401877943685, 20011.699824502644, 20065.0, 20160.39518814438, 1018.8981101889751, 1021.1320377678913, 1046.1369370269558, 1094.819354806464, 1098.423327752936, 10247.333923294962, 11077.845807822066, 11395.316281023164, 11423.771524569629, 11440.828387574193, 457464.0, 457874.0, 465507.0, 470815.0, 471609.0, 79976.20023799688, 80606.0, 82775.5861220702, 83585.58207208925, 84739.0, 1021.5709402051157, 1026.9948650256702, 1027.0397178637998, 1065.0574241796066, 1071.089573862211, 16828.326866925185, 17023.659526809643, 17606.55983600369, 17614.119294035503, 17718.645627087644, 36346.8182659085, 37905.43141852819, 39214.21571568496, 39993.0, 41217.38173927453, 50636.0, 50888.491115089855, 52340.476595235086, 53366.0, 53822.730886345315, 7830.647620857189, 7897.736362182023, 8302.916970830214, 8401.32789376836, 8467.36494762883, 7798.766037018899, 7899.802504937423, 12366.381680916098, 12770.808437873253, 13018.0, 11655.941720291345, 11673.12451566119, 11707.648770536898, 11751.941240293743, 11773.823392648947, 10673.199510036933, 10888.510017049093, 10897.945510272399, 11070.557177713123, 11619.941900290445, 11336.546538138382, 11632.651020469399, 11661.825072624088, 11966.64100076999, 11975.041996640073, 8771.16673915977, 8879.0, 8886.822263554823, 8926.68756593516, 8968.820623587622, 10712.785744284914, 11933.701657458285, 12009.039276858006, 12013.399330033639, 12069.456874440495], "value": 9169.633740966394, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.8561358250597, 1434.490755781697, 1481.8221813382395, 1600.3118658976634, 1786.7409225662288, 7318.743843965455, 7844.843103137941, 8113.716019939303, 8356.080831108573, 8362.121977192399, 8278.710245141421, 8354.456960297592, 8372.665093396272, 8375.288100511463, 8379.581020948943, 2256.9322920312416, 2260.4122928038746, 2261.5363850410668, 2278.7835155660187, 2280.133549251282, 2143.110609097223, 2159.8164156046755, 2243.842930994823, 2243.9439014024697, 2268.7844654757855, 2184.2464349799375, 2220.5336879255374, 2227.8106360959337, 2238.21662418154, 2238.597052530544, 2154.5475450155486, 2159.255057005331, 2160.729908761413, 2168.1544197762887, 2173.945651358713, 2206.6248737714627, 2216.2797090945505, 2218.234709025384, 2222.9110835566557, 2224.3882932193615, 8338.24955753985, 8391.580420978988, 8396.538190399526, 8401.075881653074, 8405.95797021011, 4928.26076088586, 5062.746862656889, 5076.416212135578, 5140.1518749406305, 5140.383154021504, 3365.478350855621, 3517.613062563116, 3587.1032241939515, 3593.8921832345072, 3594.4967704521387, 1086.397049637451, 1132.0717012050122, 1152.0553146419938, 1164.342146687119, 1171.7656468706293, 11366.772664546745, 11373.829392559119, 11427.542898284059, 11454.370009649467, 11454.48454819535, 4052.65552428041, 4223.535411104776, 4224.317558350408, 4376.824927002885, 4377.365282034088, 8993.505357205286, 9004.0, 9005.864912026325, 9005.864912026325, 9011.864822027675, 4926.236433352764, 4938.259261110862, 4943.9258411123865, 4961.181405068123, 4961.776720047606, 4080.367543030835, 4114.876553703393, 4166.274571956382, 4660.184467718203, 4669.603083737852, 3355.0102719697747, 3642.2897534980425, 3662.597114317423, 3665.486831843544, 3686.8156592170285, 1094.5621751299384, 1107.5846557540922, 1117.4915413487006, 1126.341090462089, 1127.5320741892024, 869.9826003479895, 874.9825003499894, 889.3418870036127, 898.8876390451194, 948.3172116076552, 5386.48828361305, 5424.077906755861, 5430.375506816767, 5508.9724551376985, 5635.661860288314, 419.91181851810853, 446.5623688784944, 455.06711241954525, 457.62932025059143, 459.3431393107821, 3572.392693242103, 3735.9626403735615, 3736.626337366296, 3774.6225377462033, 3792.60177681345, 9899.406035637885, 10180.134688551556, 10294.022067903537, 10309.53607087683, 10322.48387580618, 10239.590416383262, 10249.897501025043, 10269.075783179549, 10270.948645256725, 10297.691069267934, 7813.843723125506, 7886.723964661324, 7891.131975482693, 7895.7236496722335, 7899.091604465445, 5420.349558053059, 5452.536534394462, 5453.618246722692, 5544.362398324083, 5625.437456254342, 9162.587683554122, 9245.121713437213, 9262.907370926205, 9381.34330596879, 9563.856542151734, 8732.432391894507, 9209.677661281823, 9373.1564159226, 9391.389559678599, 9814.852777208205, 6487.513436492188, 6633.369829866155, 6732.495062870402, 6807.489438292247, 6931.1682598088555, 7829.843403132019, 8039.196080391914, 8106.918930810616, 8107.635156417858, 8120.75637730869, 7359.411247100326, 7361.374283185989, 7510.586917719578, 7532.0, 7566.848663026819, 7288.854222915618, 7293.562386256842, 7303.525270857377, 7416.66625001887, 7427.628618568941, 6565.671716414256, 6575.30702016296, 6632.403083722488, 6662.800115996528, 6664.833379165366, 4706.764661766966, 4716.811327546997, 4775.880602984953, 4925.876853078702, 4935.0, 4775.785089671042, 4952.603791696583, 5029.06962211992, 5041.68916081814, 5143.279940808215], "value": 4278.766694160702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.8343344894105, 331.4349034895503, 332.6673326673327, 340.50286581590876, 341.0909925049743, 5112.3098381718455, 5240.161574148132, 5246.632735708492, 5277.6305658603915, 5291.285676433685, 5076.36545431821, 5165.8450246492575, 5201.453847346031, 5210.140326846075, 5248.346770767215, 4133.607307305816, 4134.214499245141, 4147.5645057269, 4154.979225103885, 4186.74879507229, 4033.334499807528, 4149.04571948452, 4166.958330416687, 4191.413202151702, 4228.788560571959, 4053.1893621275863, 4056.71602987791, 4073.165001174752, 4094.0, 4107.732997355177, 4063.553009168989, 4084.836606535735, 4085.59144085592, 4100.1594673092095, 4126.0, 3618.113562177257, 3626.8005259710703, 3628.546431696038, 3654.689351405134, 3658.2317713280245, 5000.499950005007, 5115.488451154892, 5135.666181698178, 5150.072986862401, 5158.974205128988, 4663.720176789369, 4674.205385084544, 4739.459675605442, 4766.547178018082, 4767.189577771753, 5437.510624043815, 5474.09677403228, 5474.507294343528, 5505.256790333294, 5540.390557038722, 3763.7553559018575, 3949.585293544194, 3953.1895961328146, 3958.4062390641634, 3980.7014473914574, 5616.550675945915, 5634.464725851038, 5640.871825634889, 5659.462351076682, 5695.572832037614, 4054.0878302382316, 4055.6349928506575, 4089.427480152781, 4091.5499295077516, 4108.979455102705, 3928.7642741435607, 4084.9591504085174, 4108.198901214294, 4128.195001974646, 4130.359794231899, 4672.0, 4677.976610116928, 4698.929516057262, 4707.764611769398, 4713.670043097019, 5494.994327070671, 5495.450454954473, 5512.924979629014, 5565.998120338378, 5584.413636568183, 1327.3164320375015, 1331.760283149023, 1409.7180563887264, 1414.8302203735411, 1418.5886093032905, 866.7616405488415, 900.5452246615417, 907.7775944893543, 921.6820197032014, 928.4846909964899, 4601.0, 4625.861224163281, 4671.789769460383, 4687.7656117194, 4690.460597031385, 4838.588719958772, 4872.707637541759, 4926.285688575136, 4930.753462326869, 4968.627352948543, 4651.302304654261, 4673.836415725434, 4676.129548180755, 4731.574158325767, 4739.056986635463, 2784.206501147163, 2951.5425109108123, 2952.099609619087, 2959.201015725742, 2959.9704002959693, 5751.4118646609195, 5754.856128596819, 5779.248697669276, 5792.275965504312, 5805.8548536286935, 5501.61166385586, 5664.490195882308, 5726.541876649858, 5738.741756620962, 5753.539716822728, 5761.020626493422, 5762.567807414461, 5765.250517432791, 5774.913376299275, 5784.3926387729525, 5574.968630803152, 5601.691906945157, 5616.0, 5617.7191140442, 5634.690092044977, 5315.255864178941, 5446.502211891761, 5497.505224529811, 5511.724413779215, 5535.4187810280955, 5797.681127537857, 5803.274590676166, 5812.854678632899, 5830.2420685310635, 5831.825045248649, 3950.150717595731, 4044.8786536403954, 4068.145689405258, 4071.470708807836, 4072.5316588591504, 5324.6006549508165, 5539.362973257966, 5540.0, 5545.722713864371, 5584.581156413366, 5335.0, 5386.43442438554, 5421.918671219856, 5447.319085114361, 5462.0, 5451.536619387396, 5464.453554644663, 5479.205515200353, 5504.339479262514, 5506.972465137648, 5203.92194117081, 5375.81184658535, 5378.005069062236, 5387.649802762808, 5395.514403703685, 5448.400675925565, 5492.395836458067, 5504.669719816664, 5507.256520369699, 5507.779688812403, 5392.7573259202645, 5393.191021346829, 5401.756920938646, 5403.216533602685, 5418.701971391612], "value": 4142.42537998278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.0583832260573, 735.8491509240606, 759.0549765541901, 778.9221077892215, 821.6097353756965, 13413.195208287498, 14263.572092837205, 14302.141871487693, 14310.49913253035, 14320.355583998718, 15178.54464366068, 15295.69408611827, 15337.0, 15341.232938353094, 15358.078515289091, 650.1353200243665, 665.8235567574573, 786.7875673568133, 788.2590365056828, 812.0134037144868, 798.0104670208929, 798.6525861250375, 799.360511590728, 801.463019776751, 806.2743530822248, 852.6845067325098, 854.9572521373907, 855.2644725536034, 855.5978690015713, 855.6620135046653, 844.0588743550896, 845.530730444603, 846.5555583318745, 847.0216899481109, 847.0555330806168, 498.34134890359974, 507.0189183929109, 611.339753066687, 618.427954142421, 621.0497938154631, 15356.155411452366, 15359.0, 15386.230688465532, 15392.769108463383, 15401.0, 13742.862571374259, 14142.858571414257, 14444.711105777931, 14547.0, 14666.633334166625, 13032.152910060911, 13111.409986550629, 13139.14595551286, 13336.799948000787, 13546.187228766206, 4380.89047773805, 4397.274449715793, 4426.402435671175, 4430.601245887886, 4661.277501987197, 83058.58470707668, 83173.0, 84152.0, 84183.0, 84236.0, 11327.886721132849, 11344.546218151181, 11393.772124557463, 11796.410179490991, 12005.159638825373, 21699.674504882438, 21727.67408488874, 21744.34766956994, 21850.45373865666, 21889.0, 8278.793030174294, 8405.663773449116, 8478.83042339162, 8493.405461617751, 8713.782155446164, 4160.750354978711, 4224.619784219373, 4378.014946636981, 4381.364702118175, 4527.592516673515, 3259.2666650004035, 3329.783564068376, 3336.899893003214, 3337.9499307510405, 3351.1957130288556, 612.8039027511243, 614.2168734862996, 617.2099712368176, 618.2951435363689, 630.4389093706604, 654.5287393076977, 659.4638013873505, 670.14851805567, 675.8006388115517, 682.3279070115932, 8369.49783013021, 8617.49407098863, 8808.691695790616, 9395.424836601236, 9963.352382095141, 575.025332062159, 625.1497962770628, 646.0890144895675, 662.5494663628779, 682.3960794696729, 3928.27575266336, 4267.274563324242, 4303.074838909587, 4309.010832043762, 4378.4745830499905, 113880.0, 115028.0, 123856.0, 123972.0, 126498.0, 105390.47304763427, 105749.0, 106134.46932765287, 107083.46458267815, 108353.0, 90661.0, 91017.6168289701, 92760.53619731993, 93204.0, 97746.5112674432, 8045.557494337868, 8242.134575869688, 8379.318618042167, 8384.790380240544, 8715.869261960948, 53205.0, 53518.73240633772, 53805.46194538005, 54786.72606636941, 55632.44367556435, 47128.0, 48457.27314090362, 52205.7389713049, 69809.65095174492, 78390.6080469594, 10874.565017399216, 10877.347359158475, 11130.276532025393, 11229.66311010671, 11293.854167708108, 11836.918851113642, 11958.880411195776, 12173.20874143178, 12300.261984280973, 12350.505979760708, 11934.761304773681, 11958.940205299266, 12045.156839021185, 12060.819087713517, 12132.818007730068, 11674.591389301333, 11706.414679266172, 11996.280223186637, 12245.448954796877, 12427.44076516577, 12853.614391568268, 13696.3836627354, 13707.520236791665, 14129.646758831112, 14145.363458644591, 10279.94860025695, 10714.357138571711, 11031.062359699516, 11132.610358637408, 11214.719632009264, 9232.538373081454, 10217.284790064921, 10778.730531736455, 11297.548098075986, 11544.82682759776], "value": 7324.694828840902, "unit": "score"}], "name": "dromaeo_css", "value": 7063.589245759301, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 116.0, 114.0, 116.0, 116.0, 115.0, 117.0, 114.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 124.0, 163.0, 124.0, 125.0, 128.0, 125.0, 155.0, 124.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 163.0, 162.0, 164.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 105.0, 76.0, 76.0, 77.0, 78.0, 114.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 123.0, 83.0, 82.0, 83.0, 109.0, 81.0, 82.0, 106.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 53.0, 53.0, 52.0, 52.0, 52.0, 53.0, 54.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 90.0, 83.0, 80.0, 81.0, 84.0, 80.0, 86.0, 83.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 128.0, 131.0, 134.0, 131.0, 134.0, 138.0, 166.0, 142.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 166.0, 165.0, 166.0, 165.0, 165.0, 166.0, 169.0, 166.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 70.0, 65.0, 67.0, 66.0, 65.0, 67.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1510.1000000000001, "alertThreshold": 2.0}]} 23:36:45 INFO - Return code: 0 23:36:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:36:45 INFO - # TBPL SUCCESS # 23:36:45 INFO - Running post-action listener: _resource_record_post_action 23:36:45 INFO - [mozharness: 2016-10-04 06:36:45.972547Z] Finished run-tests step (success) 23:36:45 INFO - Running post-run listener: _resource_record_post_run 23:36:46 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 409550848; Read time: 172; Write time: 209156 23:36:46 INFO - TinderboxPrint: CPU usage
13.1% 23:36:46 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 172 23:36:46 INFO - TinderboxPrint: I/O write bytes / time
409,550,848 / 209,156 23:36:46 INFO - TinderboxPrint: CPU idle
8,301.7 (86.9%) 23:36:46 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 23:36:46 INFO - TinderboxPrint: Swap in / out
0 / 0 23:36:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103948288; Read time: 0; Write time: 54612 23:36:46 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288669696; Read time: 164; Write time: 150056 23:36:46 INFO - Running post-run listener: _upload_blobber_files 23:36:46 INFO - Blob upload gear active. 23:36:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:36:46 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 23:36:46 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:36:46 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:36:47 INFO - (blobuploader) - INFO - Open directory for files ... 23:36:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:36:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:36:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:47 INFO - (blobuploader) - INFO - Done attempting. 23:36:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:36:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:48 INFO - (blobuploader) - INFO - Done attempting. 23:36:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:36:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:52 INFO - (blobuploader) - INFO - Done attempting. 23:36:52 INFO - (blobuploader) - INFO - Iteration through files over. 23:36:52 INFO - Return code: 0 23:36:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:36:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:36:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cb128825cabaa280b7cac612d5bcb1f80381976c7b7f6b1846b36af29abee5fbddd711086d651438960f10abaa3b0d46bc8001ea27caf5992b417f3891aac52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/34265fa4386ca92034fdcc4b1418ed8441d168841482dc9bf8fd977e4a5d328204e0f04ee3106423e375c9b1d985e437702b334fef6e888c26c98c152864ca75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d312a1b534cfd540c745ab9b9c9466dbe141f062569bf4e5c0343412a92cbb55713c1ba5f715ac33ac06c8dc72effa2fa35cac55aff6d627fa52ace84380b7f7"} 23:36:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:36:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:36:52 INFO - Contents: 23:36:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cb128825cabaa280b7cac612d5bcb1f80381976c7b7f6b1846b36af29abee5fbddd711086d651438960f10abaa3b0d46bc8001ea27caf5992b417f3891aac52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/34265fa4386ca92034fdcc4b1418ed8441d168841482dc9bf8fd977e4a5d328204e0f04ee3106423e375c9b1d985e437702b334fef6e888c26c98c152864ca75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d312a1b534cfd540c745ab9b9c9466dbe141f062569bf4e5c0343412a92cbb55713c1ba5f715ac33ac06c8dc72effa2fa35cac55aff6d627fa52ace84380b7f7"} 23:36:52 INFO - Running post-run listener: copy_logs_to_upload_dir 23:36:52 INFO - Copying logs to upload dir... 23:36:52 INFO - mkdir: /builds/slave/test/build/upload/logs 23:36:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.613247 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-03 23:36:51.993042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 23:36:51.997121) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1cb128825cabaa280b7cac612d5bcb1f80381976c7b7f6b1846b36af29abee5fbddd711086d651438960f10abaa3b0d46bc8001ea27caf5992b417f3891aac52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/34265fa4386ca92034fdcc4b1418ed8441d168841482dc9bf8fd977e4a5d328204e0f04ee3106423e375c9b1d985e437702b334fef6e888c26c98c152864ca75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d312a1b534cfd540c745ab9b9c9466dbe141f062569bf4e5c0343412a92cbb55713c1ba5f715ac33ac06c8dc72effa2fa35cac55aff6d627fa52ace84380b7f7"} build_url:https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/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/Mozilla-Inbound/sha512/1cb128825cabaa280b7cac612d5bcb1f80381976c7b7f6b1846b36af29abee5fbddd711086d651438960f10abaa3b0d46bc8001ea27caf5992b417f3891aac52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/34265fa4386ca92034fdcc4b1418ed8441d168841482dc9bf8fd977e4a5d328204e0f04ee3106423e375c9b1d985e437702b334fef6e888c26c98c152864ca75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d312a1b534cfd540c745ab9b9c9466dbe141f062569bf4e5c0343412a92cbb55713c1ba5f715ac33ac06c8dc72effa2fa35cac55aff6d627fa52ace84380b7f7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 23:36:52.022586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:36:52.022974) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1475561266.327698-1791120003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:36:52.105170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 23:36:52.105485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 23:36:52.105800) ========= ========= Total master_lag: 0.16 =========